builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1477838182.81 results: success (0) buildid: 20161030061439 builduid: 38876f13cadf4b2f868f6ffe65af5d00 revision: a3b6b6e39c7965561fc750d022bee96055731226 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.812417) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.812919) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.813197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.827911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.828201) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 07:36:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-10-30 07:36:23 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124962 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.967211) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:22.967549) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.017382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.017773) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a3b6b6e39c7965561fc750d022bee96055731226 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a3b6b6e39c7965561fc750d022bee96055731226 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 07:36:24,107 truncating revision to first 12 chars 2016-10-30 07:36:24,107 Setting DEBUG logging. 2016-10-30 07:36:24,107 attempt 1/10 2016-10-30 07:36:24,107 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a3b6b6e39c79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 07:36:24,691 unpacking tar archive at: mozilla-inbound-a3b6b6e39c79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.959491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.960115) ========= script_repo_revision: a3b6b6e39c7965561fc750d022bee96055731226 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.961011) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.961652) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 07:36:23.973879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-30 07:36:23.974148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:25 INFO - MultiFileLogger online at 20161030 07:36:25 in /builds/slave/test 07:36:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:36:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:25 INFO - {'append_to_log': False, 07:36:25 INFO - 'base_work_dir': '/builds/slave/test', 07:36:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:36:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:25 INFO - 'branch': 'Mozilla-Inbound', 07:36:25 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:25 INFO - 'config_files': ('talos/linux_config.py',), 07:36:25 INFO - 'default_actions': ('clobber', 07:36:25 INFO - 'read-buildbot-config', 07:36:25 INFO - 'download-and-extract', 07:36:25 INFO - 'populate-webroot', 07:36:25 INFO - 'create-virtualenv', 07:36:25 INFO - 'install', 07:36:25 INFO - 'run-tests'), 07:36:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:25 INFO - 'download_minidump_stackwalk': True, 07:36:25 INFO - 'download_symbols': 'ondemand', 07:36:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:25 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:25 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:25 INFO - 'installer_path': 'installer.exe', 07:36:25 INFO - 'log_level': 'info', 07:36:25 INFO - 'log_name': 'talos', 07:36:25 INFO - 'log_to_console': True, 07:36:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:25 INFO - 'opt_config_files': (), 07:36:25 INFO - 'pip_index': False, 07:36:25 INFO - 'sps_profile': False, 07:36:25 INFO - 'sps_profile_interval': 0, 07:36:25 INFO - 'suite': 'dromaeojs-e10s', 07:36:25 INFO - 'system_bits': '32', 07:36:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:25 INFO - 'title': 'talos-linux64-ix-050', 07:36:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:25 INFO - 'use_talos_json': True, 07:36:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:25 INFO - 'work_dir': 'build'} 07:36:25 INFO - [mozharness: 2016-10-30 14:36:25.157040Z] Running clobber step. 07:36:25 INFO - Running pre-action listener: _resource_record_pre_action 07:36:25 INFO - Running main action method: clobber 07:36:25 INFO - rmtree: /builds/slave/test/build 07:36:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:25 INFO - Running post-action listener: _resource_record_post_action 07:36:25 INFO - [mozharness: 2016-10-30 14:36:25.618456Z] Finished clobber step (success) 07:36:25 INFO - [mozharness: 2016-10-30 14:36:25.618556Z] Running read-buildbot-config step. 07:36:25 INFO - Running pre-action listener: _resource_record_pre_action 07:36:25 INFO - Running main action method: read_buildbot_config 07:36:25 INFO - Using buildbot properties: 07:36:25 INFO - { 07:36:25 INFO - "project": "", 07:36:25 INFO - "product": "firefox", 07:36:25 INFO - "script_repo_revision": "production", 07:36:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:36:25 INFO - "repository": "", 07:36:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:36:25 INFO - "buildid": "20161030061439", 07:36:25 INFO - "stage_platform": "linux64-pgo", 07:36:25 INFO - "basedir": "/builds/slave/test", 07:36:25 INFO - "buildnumber": 1912, 07:36:25 INFO - "platform": "ubuntu64_hw", 07:36:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:36:25 INFO - "slavebuilddir": "test", 07:36:25 INFO - "branch": "mozilla-inbound", 07:36:25 INFO - "revision": "a3b6b6e39c7965561fc750d022bee96055731226", 07:36:25 INFO - "slavename": "talos-linux64-ix-050", 07:36:25 INFO - "builduid": "38876f13cadf4b2f868f6ffe65af5d00", 07:36:25 INFO - "repo_path": "integration/mozilla-inbound" 07:36:25 INFO - } 07:36:25 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:36:25 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:36:25 INFO - Running post-action listener: _resource_record_post_action 07:36:25 INFO - [mozharness: 2016-10-30 14:36:25.620926Z] Finished read-buildbot-config step (success) 07:36:25 INFO - [mozharness: 2016-10-30 14:36:25.621018Z] Running download-and-extract step. 07:36:25 INFO - Running pre-action listener: _resource_record_pre_action 07:36:25 INFO - Running main action method: download_and_extract 07:36:25 INFO - mkdir: /builds/slave/test/build/tests 07:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:25 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:36:25 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:36:25 INFO - Downloaded 1361 bytes. 07:36:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:36:25 INFO - Using the following test package requirements: 07:36:25 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'jsshell-linux-x86_64.zip'], 07:36:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:25 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:36:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:25 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:36:25 INFO - Http code: 200 07:36:25 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 07:36:25 INFO - x-amz-cf-id: -DDH6nNtHQTF8RNXnAblU2SiYieZBgtmAOLRAa2Pc_nZH6YLGPIhAw== 07:36:25 INFO - x-amz-replication-status: PENDING 07:36:25 INFO - x-amz-version-id: Us6q3AkDZPbzGaHShEYihQeht6IVkeid 07:36:25 INFO - Expected file size: 22006176 07:36:25 INFO - Obtained file size: 22006176 07:36:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:36:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:36:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:30 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:36:30 INFO - Http code: 200 07:36:30 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 07:36:30 INFO - x-amz-cf-id: 4Kg6P8_3uEEdnV31NiZDd3lXKlzvJYFYlRLVBtLbKdK83a13ZFXZBQ== 07:36:30 INFO - x-amz-replication-status: PENDING 07:36:30 INFO - x-amz-version-id: Us6q3AkDZPbzGaHShEYihQeht6IVkeid 07:36:30 INFO - Expected file size: 22006176 07:36:30 INFO - Obtained file size: 22006176 07:36:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:36:34 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:36:34 INFO - Http code: 200 07:36:34 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 07:36:34 INFO - x-amz-cf-id: zZWeA0D5I72cH_lOIs6IO1oaA8lKHgrflRE0ISqnSNEVMPIe2WJ0hw== 07:36:34 INFO - x-amz-replication-status: PENDING 07:36:34 INFO - x-amz-version-id: VIPnUgkuJO4tF53yFW25LoHsIOaYrdjk 07:36:35 INFO - Expected file size: 14409038 07:36:35 INFO - Obtained file size: 14409038 07:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:35 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:36:35 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:36:35 INFO - Downloaded 59622969 bytes. 07:36:35 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:36:35 INFO - mkdir: /builds/slave/test/properties 07:36:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:35 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:35 INFO - Contents: 07:36:35 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - Running post-action listener: set_extra_try_arguments 07:36:36 INFO - [mozharness: 2016-10-30 14:36:36.326109Z] Finished download-and-extract step (success) 07:36:36 INFO - [mozharness: 2016-10-30 14:36:36.326335Z] Running populate-webroot step. 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: populate_webroot 07:36:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:36 INFO - '--tppagecycles', 07:36:36 INFO - '7'], 07:36:36 INFO - 'tests': ['tsvgm']}}, 07:36:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['damp', 'tps']}, 07:36:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['damp', 'tps']}, 07:36:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['dromaeo_dom']}, 07:36:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['basic_compositor_video']}, 07:36:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['a11yr', 07:36:36 INFO - 'ts_paint', 07:36:36 INFO - 'tpaint', 07:36:36 INFO - 'sessionrestore', 07:36:36 INFO - 'sessionrestore_no_auto_restore', 07:36:36 INFO - 'tabpaint']}, 07:36:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tsvgx', 07:36:36 INFO - 'tsvgr_opacity', 07:36:36 INFO - 'tart', 07:36:36 INFO - 'tscrollx', 07:36:36 INFO - 'cart']}, 07:36:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:36 INFO - 'tsvgr_opacity', 07:36:36 INFO - 'tart', 07:36:36 INFO - 'tscrollx', 07:36:36 INFO - 'cart']}, 07:36:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s'], 07:36:36 INFO - 'tests': ['tp5o']}, 07:36:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'tests': ['tp5o']}, 07:36:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--disable-e10s', 07:36:36 INFO - '--xperf_path', 07:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:36 INFO - 'tests': ['tp5n']}, 07:36:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:36 INFO - 'talos_options': ['--xperf_path', 07:36:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:36 INFO - 'tests': ['tp5n']}}, 07:36:36 INFO - 'talos.zip': {'path': '', 07:36:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:36 INFO - Running post-action listener: _resource_record_post_action 07:36:36 INFO - [mozharness: 2016-10-30 14:36:36.346375Z] Finished populate-webroot step (success) 07:36:36 INFO - [mozharness: 2016-10-30 14:36:36.346462Z] Running create-virtualenv step. 07:36:36 INFO - Running pre-action listener: _resource_record_pre_action 07:36:36 INFO - Running main action method: create_virtualenv 07:36:36 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:36:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:36 INFO - Using real prefix '/usr' 07:36:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:38 INFO - Installing pip.................done. 07:36:38 INFO - Return code: 0 07:36:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:39 INFO - Reading from file tmpfile_stdout 07:36:39 INFO - Output received: 07:36:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:36:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:36:39 INFO - Using env: {'DISPLAY': ':0', 07:36:39 INFO - 'HOME': '/home/cltbld', 07:36:39 INFO - 'LANG': 'en_US.UTF-8', 07:36:39 INFO - 'LANGUAGE': 'en_US:en', 07:36:39 INFO - 'LOGNAME': 'cltbld', 07:36:39 INFO - 'MAIL': '/var/mail/cltbld', 07:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:39 INFO - 'MOZ_NO_REMOTE': '1', 07:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:39 INFO - 'NO_EM_RESTART': '1', 07:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:39 INFO - 'PWD': '/builds/slave/test', 07:36:39 INFO - 'SHELL': '/bin/bash', 07:36:39 INFO - 'SHLVL': '1', 07:36:39 INFO - 'TERM': 'linux', 07:36:39 INFO - 'TMOUT': '86400', 07:36:39 INFO - 'USER': 'cltbld', 07:36:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:39 INFO - '_': '/tools/buildbot/bin/python'} 07:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:36:39 INFO - Cleaning up... 07:36:39 INFO - Return code: 0 07:36:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:36:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:36:39 INFO - Using env: {'DISPLAY': ':0', 07:36:39 INFO - 'HOME': '/home/cltbld', 07:36:39 INFO - 'LANG': 'en_US.UTF-8', 07:36:39 INFO - 'LANGUAGE': 'en_US:en', 07:36:39 INFO - 'LOGNAME': 'cltbld', 07:36:39 INFO - 'MAIL': '/var/mail/cltbld', 07:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:39 INFO - 'MOZ_NO_REMOTE': '1', 07:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:39 INFO - 'NO_EM_RESTART': '1', 07:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:39 INFO - 'PWD': '/builds/slave/test', 07:36:39 INFO - 'SHELL': '/bin/bash', 07:36:39 INFO - 'SHLVL': '1', 07:36:39 INFO - 'TERM': 'linux', 07:36:39 INFO - 'TMOUT': '86400', 07:36:39 INFO - 'USER': 'cltbld', 07:36:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:39 INFO - '_': '/tools/buildbot/bin/python'} 07:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:39 INFO - Downloading/unpacking psutil>=3.1.1 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:41 INFO - Installing collected packages: psutil 07:36:41 INFO - Running setup.py install for psutil 07:36:41 INFO - building 'psutil._psutil_linux' extension 07:36:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:36:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:36:41 INFO - building 'psutil._psutil_posix' extension 07:36:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:36:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:36:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:42 INFO - Successfully installed psutil 07:36:42 INFO - Cleaning up... 07:36:42 INFO - Return code: 0 07:36:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:36:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:36:42 INFO - Using env: {'DISPLAY': ':0', 07:36:42 INFO - 'HOME': '/home/cltbld', 07:36:42 INFO - 'LANG': 'en_US.UTF-8', 07:36:42 INFO - 'LANGUAGE': 'en_US:en', 07:36:42 INFO - 'LOGNAME': 'cltbld', 07:36:42 INFO - 'MAIL': '/var/mail/cltbld', 07:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:42 INFO - 'MOZ_NO_REMOTE': '1', 07:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:42 INFO - 'NO_EM_RESTART': '1', 07:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:42 INFO - 'PWD': '/builds/slave/test', 07:36:42 INFO - 'SHELL': '/bin/bash', 07:36:42 INFO - 'SHLVL': '1', 07:36:42 INFO - 'TERM': 'linux', 07:36:42 INFO - 'TMOUT': '86400', 07:36:42 INFO - 'USER': 'cltbld', 07:36:42 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:42 INFO - '_': '/tools/buildbot/bin/python'} 07:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:44 INFO - Installing collected packages: mozsystemmonitor 07:36:44 INFO - Running setup.py install for mozsystemmonitor 07:36:44 INFO - Successfully installed mozsystemmonitor 07:36:44 INFO - Cleaning up... 07:36:44 INFO - Return code: 0 07:36:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:44 INFO - Using env: {'DISPLAY': ':0', 07:36:44 INFO - 'HOME': '/home/cltbld', 07:36:44 INFO - 'LANG': 'en_US.UTF-8', 07:36:44 INFO - 'LANGUAGE': 'en_US:en', 07:36:44 INFO - 'LOGNAME': 'cltbld', 07:36:44 INFO - 'MAIL': '/var/mail/cltbld', 07:36:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:44 INFO - 'MOZ_NO_REMOTE': '1', 07:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:44 INFO - 'NO_EM_RESTART': '1', 07:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:44 INFO - 'PWD': '/builds/slave/test', 07:36:44 INFO - 'SHELL': '/bin/bash', 07:36:44 INFO - 'SHLVL': '1', 07:36:44 INFO - 'TERM': 'linux', 07:36:44 INFO - 'TMOUT': '86400', 07:36:44 INFO - 'USER': 'cltbld', 07:36:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:44 INFO - '_': '/tools/buildbot/bin/python'} 07:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:36:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:36:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:36:46 INFO - warning: no files found matching '*.txt' 07:36:46 INFO - no previously-included directories found matching 'build' 07:36:46 INFO - no previously-included directories found matching 'dist' 07:36:46 INFO - no previously-included directories found matching '.git*' 07:36:46 INFO - Installing collected packages: jsonschema, functools32 07:36:47 INFO - Running setup.py install for functools32 07:36:47 INFO - warning: no files found matching '*.txt' 07:36:47 INFO - no previously-included directories found matching 'build' 07:36:47 INFO - no previously-included directories found matching 'dist' 07:36:47 INFO - no previously-included directories found matching '.git*' 07:36:47 INFO - Successfully installed jsonschema functools32 07:36:47 INFO - Cleaning up... 07:36:47 INFO - Return code: 0 07:36:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:36:47 INFO - Using env: {'DISPLAY': ':0', 07:36:47 INFO - 'HOME': '/home/cltbld', 07:36:47 INFO - 'LANG': 'en_US.UTF-8', 07:36:47 INFO - 'LANGUAGE': 'en_US:en', 07:36:47 INFO - 'LOGNAME': 'cltbld', 07:36:47 INFO - 'MAIL': '/var/mail/cltbld', 07:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:47 INFO - 'MOZ_NO_REMOTE': '1', 07:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:47 INFO - 'NO_EM_RESTART': '1', 07:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:47 INFO - 'PWD': '/builds/slave/test', 07:36:47 INFO - 'SHELL': '/bin/bash', 07:36:47 INFO - 'SHLVL': '1', 07:36:47 INFO - 'TERM': 'linux', 07:36:47 INFO - 'TMOUT': '86400', 07:36:47 INFO - 'USER': 'cltbld', 07:36:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:47 INFO - '_': '/tools/buildbot/bin/python'} 07:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:36:47 INFO - Cleaning up... 07:36:47 INFO - Return code: 0 07:36:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:36:47 INFO - Using env: {'DISPLAY': ':0', 07:36:47 INFO - 'HOME': '/home/cltbld', 07:36:47 INFO - 'LANG': 'en_US.UTF-8', 07:36:47 INFO - 'LANGUAGE': 'en_US:en', 07:36:47 INFO - 'LOGNAME': 'cltbld', 07:36:47 INFO - 'MAIL': '/var/mail/cltbld', 07:36:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:47 INFO - 'MOZ_NO_REMOTE': '1', 07:36:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:47 INFO - 'NO_EM_RESTART': '1', 07:36:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:47 INFO - 'PWD': '/builds/slave/test', 07:36:47 INFO - 'SHELL': '/bin/bash', 07:36:47 INFO - 'SHLVL': '1', 07:36:47 INFO - 'TERM': 'linux', 07:36:47 INFO - 'TMOUT': '86400', 07:36:47 INFO - 'USER': 'cltbld', 07:36:47 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:47 INFO - '_': '/tools/buildbot/bin/python'} 07:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:36:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:36:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:50 INFO - Downloading docopt-0.6.1.tar.gz 07:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:36:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:36:50 INFO - Running setup.py install for blobuploader 07:36:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:36:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:36:50 INFO - Running setup.py install for requests 07:36:50 INFO - Running setup.py install for docopt 07:36:50 INFO - Successfully installed blobuploader requests docopt 07:36:50 INFO - Cleaning up... 07:36:50 INFO - Return code: 0 07:36:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:36:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:50 INFO - Using env: {'DISPLAY': ':0', 07:36:50 INFO - 'HOME': '/home/cltbld', 07:36:50 INFO - 'LANG': 'en_US.UTF-8', 07:36:50 INFO - 'LANGUAGE': 'en_US:en', 07:36:50 INFO - 'LOGNAME': 'cltbld', 07:36:50 INFO - 'MAIL': '/var/mail/cltbld', 07:36:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:50 INFO - 'MOZ_NO_REMOTE': '1', 07:36:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:50 INFO - 'NO_EM_RESTART': '1', 07:36:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:50 INFO - 'PWD': '/builds/slave/test', 07:36:50 INFO - 'SHELL': '/bin/bash', 07:36:50 INFO - 'SHLVL': '1', 07:36:50 INFO - 'TERM': 'linux', 07:36:50 INFO - 'TMOUT': '86400', 07:36:50 INFO - 'USER': 'cltbld', 07:36:50 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:50 INFO - '_': '/tools/buildbot/bin/python'} 07:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Running setup.py (path:/tmp/pip-Rw2m9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Running setup.py (path:/tmp/pip-JVw7WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:51 INFO - Running setup.py (path:/tmp/pip-gnTf_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:51 INFO - Running setup.py (path:/tmp/pip-idS_AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:51 INFO - Running setup.py (path:/tmp/pip-Kebfqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:51 INFO - Running setup.py (path:/tmp/pip-UaNfyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:51 INFO - Running setup.py (path:/tmp/pip-VtbTvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:51 INFO - Running setup.py (path:/tmp/pip-gIiqDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:51 INFO - Running setup.py (path:/tmp/pip-7k7PL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:51 INFO - Running setup.py (path:/tmp/pip-z0qyMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:51 INFO - Running setup.py (path:/tmp/pip-w1OdIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:51 INFO - Running setup.py (path:/tmp/pip-Zyt4e1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Running setup.py (path:/tmp/pip-I0gC56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Running setup.py (path:/tmp/pip-d6Fe59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Running setup.py (path:/tmp/pip-NN5IbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Running setup.py (path:/tmp/pip-0patFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:52 INFO - Running setup.py (path:/tmp/pip-JaSxYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:36:52 INFO - Running setup.py install for manifestparser 07:36:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozcrash 07:36:52 INFO - Running setup.py install for mozdebug 07:36:52 INFO - Running setup.py install for mozdevice 07:36:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozfile 07:36:52 INFO - Running setup.py install for mozhttpd 07:36:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:36:52 INFO - Running setup.py install for mozinfo 07:36:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozInstall 07:36:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozleak 07:36:53 INFO - Running setup.py install for mozlog 07:36:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for moznetwork 07:36:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozprocess 07:36:53 INFO - Running setup.py install for mozprofile 07:36:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozrunner 07:36:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:36:53 INFO - Running setup.py install for mozscreenshot 07:36:53 INFO - Running setup.py install for moztest 07:36:54 INFO - Running setup.py install for mozversion 07:36:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:36:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:36:54 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:36:54 INFO - Running setup.py (path:/tmp/pip-ZFu3LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 INFO - Running setup.py (path:/tmp/pip-vtQiBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 INFO - Running setup.py (path:/tmp/pip-pb13OJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 INFO - Running setup.py (path:/tmp/pip-Kxu8b7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:36:54 INFO - Running setup.py (path:/tmp/pip-Q1ddoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:36:54 INFO - Running setup.py (path:/tmp/pip-fdYd1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:36:54 INFO - Running setup.py (path:/tmp/pip-Y9hajq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:36:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:36:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:36:54 INFO - Running setup.py (path:/tmp/pip-m1cYtk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:36:55 INFO - Running setup.py (path:/tmp/pip-QRHxaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:36:55 INFO - Running setup.py (path:/tmp/pip-a3q3JG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 INFO - Running setup.py (path:/tmp/pip-FIPGhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 INFO - Running setup.py (path:/tmp/pip-EKrzZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 INFO - Running setup.py (path:/tmp/pip-xVz3J7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 INFO - Running setup.py (path:/tmp/pip-vsPGtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 INFO - Running setup.py (path:/tmp/pip-WBMBTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:36:55 INFO - Running setup.py (path:/tmp/pip-tMKNfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:36:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:36:55 INFO - Running setup.py (path:/tmp/pip-qxAJEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:36:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:57 INFO - Downloading blessings-1.6.tar.gz 07:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:36:57 INFO - Installing collected packages: blessings 07:36:57 INFO - Running setup.py install for blessings 07:36:57 INFO - Successfully installed blessings 07:36:57 INFO - Cleaning up... 07:36:57 INFO - Return code: 0 07:36:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Current package versions: 07:36:58 INFO - argparse == 1.2.1 07:36:58 INFO - blessings == 1.6 07:36:58 INFO - blobuploader == 1.2.4 07:36:58 INFO - docopt == 0.6.1 07:36:58 INFO - functools32 == 3.2.3-2 07:36:58 INFO - jsonschema == 2.5.1 07:36:58 INFO - manifestparser == 1.1 07:36:58 INFO - mozInstall == 1.12 07:36:58 INFO - mozcrash == 0.17 07:36:58 INFO - mozdebug == 0.1 07:36:58 INFO - mozdevice == 0.48 07:36:58 INFO - mozfile == 1.2 07:36:58 INFO - mozhttpd == 0.7 07:36:58 INFO - mozinfo == 0.9 07:36:58 INFO - mozleak == 0.1 07:36:58 INFO - mozlog == 3.4 07:36:58 INFO - moznetwork == 0.27 07:36:58 INFO - mozprocess == 0.23 07:36:58 INFO - mozprofile == 0.28 07:36:58 INFO - mozrunner == 6.12 07:36:58 INFO - mozscreenshot == 0.1 07:36:58 INFO - mozsystemmonitor == 0.3 07:36:58 INFO - moztest == 0.7 07:36:58 INFO - mozversion == 1.4 07:36:58 INFO - psutil == 3.1.1 07:36:58 INFO - requests == 1.2.3 07:36:58 INFO - wsgiref == 0.1.2 07:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9149dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cb0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:36:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Running post-action listener: _resource_record_post_action 07:36:58 INFO - Running post-action listener: _start_resource_monitoring 07:36:58 INFO - Starting resource monitoring. 07:36:58 INFO - [mozharness: 2016-10-30 14:36:58.552758Z] Finished create-virtualenv step (success) 07:36:58 INFO - [mozharness: 2016-10-30 14:36:58.553361Z] Running install step. 07:36:58 INFO - Running pre-action listener: _resource_record_pre_action 07:36:58 INFO - Running main action method: install 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:36:58 INFO - Reading from file tmpfile_stdout 07:36:58 INFO - Output received: 07:36:58 INFO - Usage: mozinstall [options] installer 07:36:58 INFO - Options: 07:36:58 INFO - -h, --help show this help message and exit 07:36:58 INFO - -d DEST, --destination=DEST 07:36:58 INFO - Directory to install application into. [default: 07:36:58 INFO - "/builds/slave/test"] 07:36:58 INFO - --app=APP Application being installed. [default: firefox] 07:36:58 INFO - mkdir: /builds/slave/test/build/application 07:36:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:36:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:15 INFO - Reading from file tmpfile_stdout 07:37:15 INFO - Output received: 07:37:15 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:15 INFO - Running post-action listener: _resource_record_post_action 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.809761Z] Finished install step (success) 07:37:15 INFO - [mozharness: 2016-10-30 14:37:15.810033Z] Running run-tests step. 07:37:15 INFO - Running pre-action listener: _resource_record_pre_action 07:37:15 INFO - Running main action method: run_tests 07:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:15 INFO - Python 2.7.3 07:37:15 INFO - Return code: 0 07:37:15 INFO - grabbing minidump binary from tooltool 07:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cadf60>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2caed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2caf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:37:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:37:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:37:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:15 INFO - Return code: 0 07:37:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:37:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:37:15 INFO - Using env: {'DISPLAY': ':0', 07:37:15 INFO - 'HOME': '/home/cltbld', 07:37:15 INFO - 'LANG': 'en_US.UTF-8', 07:37:15 INFO - 'LANGUAGE': 'en_US:en', 07:37:15 INFO - 'LOGNAME': 'cltbld', 07:37:15 INFO - 'MAIL': '/var/mail/cltbld', 07:37:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:15 INFO - 'MOZ_NO_REMOTE': '1', 07:37:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:15 INFO - 'NO_EM_RESTART': '1', 07:37:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:15 INFO - 'PWD': '/builds/slave/test', 07:37:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:15 INFO - 'SHELL': '/bin/bash', 07:37:15 INFO - 'SHLVL': '1', 07:37:15 INFO - 'TERM': 'linux', 07:37:15 INFO - 'TMOUT': '86400', 07:37:15 INFO - 'USER': 'cltbld', 07:37:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196', 07:37:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:15 INFO - '_': '/tools/buildbot/bin/python'} 07:37:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:37:16 INFO - mozversion application_buildid: 20161029063800 07:37:16 INFO - mozversion application_changeset: a3b6b6e39c7965561fc750d022bee96055731226 07:37:16 INFO - mozversion application_display_name: Nightly 07:37:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:16 INFO - mozversion application_name: Firefox 07:37:16 INFO - mozversion application_remotingname: firefox 07:37:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:37:16 INFO - mozversion application_vendor: Mozilla 07:37:16 INFO - mozversion application_version: 52.0a1 07:37:16 INFO - mozversion platform_buildid: 20161029063800 07:37:16 INFO - mozversion platform_changeset: a3b6b6e39c7965561fc750d022bee96055731226 07:37:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:37:16 INFO - mozversion platform_version: 52.0a1 07:37:16 INFO - using testdate: 1477838236 07:37:16 INFO - actual date: 1477838236 07:37:16 INFO - starting webserver on 'localhost:50036' 07:37:16 INFO - SUITE-START | Running 2 tests 07:37:16 INFO - TEST-START | dromaeo_css 07:37:16 INFO - operating with platform_type : linux_ 07:37:16 INFO - Initialising browser for dromaeo_css test... 07:37:16 INFO - TEST-INFO | started process 8440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FSi4o/profile http://localhost:50036/getInfo.html) 07:37:20 INFO - PROCESS | 8440 | __metrics Screen width/height:1600/1200 07:37:20 INFO - PROCESS | 8440 | colorDepth:24 07:37:20 INFO - PROCESS | 8440 | Browser inner width/height: 1024/697 07:37:20 INFO - PROCESS | 8440 | __metrics 07:37:20 ERROR - PROCESS | 8440 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 07:37:21 INFO - TEST-INFO | 8440: exit 0 07:37:21 INFO - Browser initialized. 07:37:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:21 INFO - TEST-INFO | started process 8566 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FSi4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:33 INFO - PROCESS | 8566 | RSS: Main: 185856000 07:37:33 INFO - PROCESS | 8566 | 07:38:23 INFO - PROCESS | 8566 | 1477838303558 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:40:34 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50036/tests/dromaeo/cssquery-ext.html) 07:40:36 INFO - PROCESS | 8566 | RSS: Main: 196866048 07:40:36 INFO - PROCESS | 8566 | 07:43:38 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-ext.html (next: http://localhost:50036/tests/dromaeo/cssquery-jquery.html) 07:43:39 INFO - PROCESS | 8566 | RSS: Main: 195461120 07:43:39 INFO - PROCESS | 8566 | 07:46:41 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50036/tests/dromaeo/cssquery-mootools.html) 07:46:42 INFO - PROCESS | 8566 | RSS: Main: 197394432 07:46:42 INFO - PROCESS | 8566 | 07:49:43 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50036/tests/dromaeo/cssquery-prototype.html) 07:49:44 INFO - PROCESS | 8566 | RSS: Main: 194351104 07:49:44 INFO - PROCESS | 8566 | 07:52:47 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50036/tests/dromaeo/cssquery-yui.html) 07:52:47 INFO - PROCESS | 8566 | RSS: Main: 197689344 07:52:47 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | Cycle 1(1): loaded http://localhost:50036/tests/dromaeo/cssquery-yui.html (next: http://localhost:50036/tests/dromaeo/cssquery-dojo.html) 07:55:50 INFO - PROCESS | 8566 | RSS: Main: 196808704 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | __start_tp_report 07:55:50 INFO - PROCESS | 8566 | _x_x_mozilla_page_load 07:55:50 INFO - PROCESS | 8566 | _x_x_mozilla_page_load_details 07:55:50 INFO - PROCESS | 8566 | |i|pagename|runs| 07:55:50 INFO - PROCESS | 8566 | |0;dojo.html;3075.0774767569724;3075.9384812303742;3087.397957398307;3093.8298393588357;3096.6284045914495;5375.43557926418;5471.316085489314;5502.58730595205;5513.2005859150395;5542.473465020827;5429.158480435539;5486.177073438987;5532.2531458253125;5576.052071147905;5617.101263797793;4987.625928055401;5008.874778130539;5031.32077169581;5038.5969122470115;5087.6184286178495;5049.24261360797;5133.409657889353;5174.327337446127;5175.24958880962;5228.660137091077;4886.755662216875;5045.495450454925;5077.314562534048;5080.1363768159135;5093.719845408501;4903.975480122613;4945.134601444769;4949.257611358289;5002.224655178453;5075.720835354054;4929.65492415531;4950.504949505021;4960.950390496085;4989.90020199594;5032.572231360302;5441.265429167091;5489.643173193769;5503.3395992481155;5515.586331025149;5530.446955304477;5748.7125643717645;5778.104393818923;5786.942130578683;5849.298084229919;5875.118732190205;5962.373950735154;5968;5991.850203744898;6013.849653758647;6022.939770602326;5552.888942221173;5555.055640541118;5560.304961879765;5570.025245582047;5571.637843540157;5929.37741537141;5938.762449502058;5959.433853783884;6072.574919755575;6093.878122437526;5753.079507278815;5812.273465816773;5853.590248682552;5908.586398952032;5919.970400147971;5924.763009479659;5926.140709597171;5926.1999630049395;5928.584999050111;5936;5668.291463567054;5720.48515633595;5844.970775146097;5857.853553661193;5877.794277200277;5922.970385148046;5923.733431995571;5928.258967629046;5929.229200203946;5995.250593675791;4492.101579684077;4492.910141797146;4502.414686090853;4502.527234640381;4557.6581756368405;3928.4500169976227;3941.0541470046983;3981.9402708959387;3992.8802135935966;4023.9597604023584;5675.829725108253;5685.829425117253;5753.252077229933;5753.769849206069;5754.165645981309;5909.763609455659;5989.131575921467;6000.519958403317;6014;6019.428154325332;5522.22688823565;5570.442955704478;5695.857603559944;5700.857478562986;5701.372848986608;4951.777170027357;4977.32806071183;4979.4771548987555;5007.774650140753;5018.89962200754;6095.969520152371;6154.1999540059505;6167.938320616737;6169.784057558054;6170.475509581646;5814.767409303749;5959.761609535743;5960.403959604005;5967.403259673998;5992.13114098462;5998.430149135826;6073.453389194994;6116.510679145568;6126.5098792097415;6145.67867908384;5785;5798.391168927371;5812.447817457335;5838.4453476919625;5904.3800400959;5929.555283353852;5968.045112781934;5973.372795856546;5976.19321391624;5986.2517185351835;5579.804706835242;5645.125005624135;5666.433356664301;5725.456081672234;5727.455891690282;5729.8567535811935;5755.510781583613;5758.078707406795;5759.107338362561;5761.8559536011935;5690.402507736628;5718.456746609066;5746.683932383759;5751.884962300815;5756.395578464369;5732.426757324234;5811.041178205718;5854.443827836349;5858.7070646466655;5936.139259807217;5701.230333905036;5712.80005199816;5723.542116630742;5756.1941328214925;5758.1362795581 07:55:50 INFO - PROCESS | 8566 | |1;ext.html;567.2965522751787;574.0155633089254;581.7876475086593;594.5629961977949;605.1467430922401;38914.80542597287;43748;43780.3432948506;43846.34230486545;43903;44028.33957490632;44574.77712611432;44613.77693111538;44640.55359446404;44642.33036504455;8602.612882420306;8684.956575217115;8743.912560874405;8747.912520874774;8802.559872006406;8665.263452606505;8742.86885696715;8755.562221888911;8774.64901403943;8781.692640757576;8721.95639021804;8763.737087887373;8784.736457906272;8800.691975780848;8861.867071993925;8720.651173953034;8745;8811.162939520735;8815.559222038937;8816.73549793504;8584.27033702136;8597.312215022846;8606.913930860674;8673.696420625249;8677.305815534743;41815.37276940848;42168.57831421677;42200.78899605482;42296.57703422957;42324.576754232374;2979.865906034234;3163.3040731039137;3308.5698859148397;3463.930721385583;3514.3322768674125;31048.379032419452;31325.216869578217;31857.84071079653;31898.362032759447;31899.681003189904;3634.6910512606196;3675.1363429594026;3772.264408440355;3856.0359910022494;3886.4947556817715;336471;338083;339598;341876.9999999975;342829;57426.425735742945;57464.71267643635;57839.42160578424;58281.63508115961;58347;60192.39807601868;60256.39743602508;60289.69855150784;60355.69822150949;60565.697171514745;15432.459863904709;15675.216239187996;15708.21458927049;15820.525384238492;15927;11288.435578221057;11340.43297835105;11394;11440.885591143982;11478.565179352581;16144.434944776876;16366.590835228977;16399.064224586014;16411.58971025734;16823.747643785355;6725.428338591177;6859.657017149123;6874.690638921161;6907;7037.753678621224;936.7939053408239;991.548845275398;1064.5422468338534;1098.0885864732254;1134;31158;31423.528647070314;32220.35559288848;32823.83588082044;33018;1095.2059756676347;1109.7170221593442;1131.1742428027585;1136.8806275341135;1185.7569198314325;16130;16939.745903811454;16959.745603815954;16982.57543561421;17099.74350384745;496218;499578;499747;500184;500380;56852.43147568554;56943.14585281224;57386;57435.42564574301;57520.71239643859;1283.2108253424076;1303.3483258370813;1350.1089281074444;1351.5472316773794;1365.2900491744238;29425.558616621194;30938.226544336572;31673.366532668755;31852.9663803578;32096.35807283888;51110.488895110575;51752;51973.7401312991;51985;52062.219066713275;358182;360115;360793;361188;361380;40164.1967160661;40263;40853.59146408498;40941;41116;46652.300215497475;47301.52698473109;47833.52166478291;49505.752471237414;49669.50330496793;38318.61681383262;39824.2035159301;40007.79996100001;40625.39061914015;41364;39608.801955990035;40912.1817563653;41474.37788433115;41668.374974374805;41927.37108943307;40308.798456007535;40560;40853.59146408498;41610.16779664329;41717;32409.675903240666;35062.12344691403;35874.64125358713;36487.08782280464;36875.44686829646;28302;28476.288092797844;28520.714792851806;28583.714162858105;28594.857025714737 07:55:50 INFO - PROCESS | 8566 | |2;jquery.html;383.50910834132304;390.8182695046803;391.22342150830616;399.6183644619389;418.62323908482364;17948.910255448736;19085.522861928457;19516.90241548792;19557;19844.20623175071;17444.738328925076;17553.736693949602;17864.285428582873;17933.7309940351;18190.909045454755;5403.432639572838;5471.671699698011;5636.830895073133;5652.491275785179;5737.311522617292;5656.858578535528;5676.205331253628;5690.174924635925;5699.202111704365;5700.828975130753;5600.691961942091;5653.038983372837;6012.759489620432;6423.93576064238;6444.903326450107;6264.27960784511;6439.388258115471;6443.323451037644;6473.8705225895455;6519.250286217099;5460.235567020621;5519.365272993617;5532.474414930575;5542.8337149885565;5581.107022876361;12924.353782310847;12991.805122923164;12991.935040324737;13126.60620181396;13202.141860779115;2195.6267434536167;2360.5750964826325;2363.6218205087102;2422.5639384910887;2437.878106094688;9266.351355405124;9449.527523623792;9617.51912404377;9861.408315501092;10015.74960625983;1897.155765684271;1935.7870634230223;1939.486036200408;1996.99001504993;2009.6382651122792;83190.58404708059;83308.58345708232;84070;84981.57509212477;86206;10383.94808025955;10551;10591.57633694659;11119.110471162288;11163;15197;15291.847081529264;15309.387624494895;15321.693566128837;15359.155246461329;7353.852922941511;7573.734919277909;7630;7794.6882124714375;7902.920970790334;7177.389921856597;7302.415806735448;7305.598192099379;7514.924850751422;7524.849503009909;4289.549597292239;4313.482382114166;4451.816950880137;4565.109803588269;4598.563136502027;1936.66108431024;1954.491832123658;1986.0069965017492;1986.7218589397496;2013.194722111138;900.5677274908081;951.6764300137847;956.502618638318;1035.5754140802235;1066.3713945125303;18468;18680.719789203173;18992.43022709321;19147.329843455413;19490.512737181685;962.9374090684223;976.9316147869723;980.9901900981041;1009.7728011197422;1024.2062401638789;9930.50347482623;10350;10409.68770936873;11000.679918409682;11156.442177891073;397746;400215;405944;407618;411856;92868.53565732263;93035.53482232681;94138.5293073544;94156;94614.5269273663;1041.1670663469345;1048.7692707604315;1082.6697857153645;1092.7158938676002;1098.7363032872054;16126.596835079217;17015;17229.91385043067;17241.22414491376;17678.734818977984;40628.79685601553;41603.79198104111;41681;42533;42964;54859.72570137124;55662.44337556572;56702.43297567136;57076;59524.70237648784;6702.463802895659;7192.352688258082;8117.756467305991;8175.509469431853;8286.751397457845;9215.677451289173;12682.302473364054;13085.869141308845;13227.338633068115;13241.205527667986;11532.308061516336;11567.305961642329;11574.826377604511;11636.76726465449;11900.702482438008;11380;11417.543298267976;11465.828012579985;11483.885161148615;11602.70993225176;11425.31448113116;11612.5354985803;11665.075262581578;11689.655689595806;12113.273203607812;8104.189581042085;8198.262156405952;8276.83446331082;8360.244348686843;8423;9140.314476414429;11157.553697851996;11440.82838757436;11625.825612615648;12174.269543827399 07:55:50 INFO - PROCESS | 8566 | |3;mootools.html;1472.4772705689477;1485.1386196006315;1615.5557221764013;1719.3724290633916;1757.4727581725494;7295.890561641566;7515.361194298491;8113.756587302383;8667.436616619916;8668.176523230299;8126.309263712592;8391.706290279826;8402.453840500364;8604.741857744277;8637.568121593926;2312.5490529346785;2327.1273272522803;2327.697399338092;2332.242021343062;2338;2296.334063121693;2335.439494521311;2338.707661542307;2338.7895089441945;2342.7188737351457;2277.339571524256;2278.5556816420803;2306.6194077977198;2313.9305820825316;2330.1611419888827;2249.3589327041714;2249.5613355395703;2259.9774002259933;2260.175036111824;2266.0935625749667;2239.8096161826265;2254.3462395905167;2255.154317131076;2257.932262032142;2263.7849404306567;8443.70447034357;8524.062353141211;8563;8605.483670979762;8617.052124266325;5001.874953126165;5109.105906466353;5141.897162056738;5175.974120129413;5185.714785686786;3141.5915930929064;3227.6288226853976;3442.913927151816;3482.7736197147356;3505.789652620851;1087.994560027195;1107.4739498738036;1113.4766659669942;1119.8880111988817;1171.8242263660434;11744.471498782576;11889.643310700692;11889.762204755943;11910.940445297805;11940.820887686605;4341.153475072394;4625.398698169217;4701.600363969101;4704.082703872712;4721.197396442613;9742.123208911233;9873.062059104373;9902.504874756234;9908.35595686278;9952.452615106095;5118;5148.536631703165;5157.974210128926;5165.638405311592;5179.171332586768;4003.099302656937;4131.29767939445;4556.658250631216;4667.486576476653;4702.553257440538;3804.619538046173;3813.2754776592915;3874.438206460104;3889.902752431212;3911.3350730375905;1264.1467009768553;1273.936303184837;1274.1081243129847;1288.8324517812625;1300.655326338521;784.4469648897514;942.2273735536932;950.5247376311844;951.3578334624101;965.0542468381026;5765.971170144123;5802.1296805479515;5825.970870145707;5839.620424672467;5891.646501209942;428.5628658768039;430.07104653947323;431.11190946650004;453.5238000099882;458.37889659511546;3832.5017747692623;3899.161680238762;3920.1963597463023;3951.091249012743;3965.0682089708894;10171.186305095574;10712;10713.250072495006;10719.410432426292;10727.356358618508;10304.484775761182;10437.686869393778;10502.632407865687;10530.63142790014;10543.472826358651;7911.564863932539;7933.801654958672;7943.682252709827;8030.156833532512;8084.1107478177355;5632.85917852057;5755.8561035974435;5777.768889244551;5814.30228372598;5855.443732845373;9456.952715236379;9459.148676618863;9507.66723164686;9570.33007689455;9623.807523849624;9636.71089867305;9751.804963900824;9766.46284454362;9808.852867206855;9834.557444914853;6260.874782504416;6490.935090649033;6963.93036069653;7141.714331426685;7209.6034718091005;7855.450118491651;8173.918260817553;8218.465799722999;8222.876656850272;8228.588570571566;7371.852562948819;7375.963120184365;7486.5508069516;7567.31894129531;7652.923470765444;7140.107486564179;7318.231585683427;7331.596762178131;7364.484486085923;7380.889286660812;6703.698333574904;6793.796186114425;6801.863962720817;6814.557053791487;6815.318468153343;4822.156122678587;4876.561109500162;4930.260460930889;4930.531599498042;5010.123228434936;4840.1287768200655;5013.373328333958;5013.649044566845;5026.949730502648;5101.132807422821 07:55:50 INFO - PROCESS | 8566 | |4;prototype.html;325.74591818381657;332.78701630956186;339.37554898985894;342.58889332800646;342.81316682408095;5353.812616558412;5459.3994660587305;5523.6409633373805;5597.888042239158;5640.238567793347;5231.352124080921;5333.399980006002;5353.384360798509;5354.2771725817;5381.973090134554;4207.663386929038;4209.47431541076;4222.74663520189;4252.766097864632;4264.893377665552;4217.261979153651;4249.915001699964;4251.5960983706655;4268.317069268917;4288.914221715564;4212.178625168093;4233.1322078973735;4244.0663054128045;4246.662301375057;4251.914961700764;4245.851395201169;4253.80857861397;4266.33354153654;4269.380939763717;4269.487661480643;3700.204456041964;3790.8294126764363;3812.5996770338993;3815.5421349437966;3815.8855234343014;5326.520613144836;5329.9467005330225;5340.25236466895;5355.116405793039;5397.865053373658;4853.3690620219495;4877.975610121962;4888.315635810989;4905.626424601118;4916.164252077119;5565.387807341189;5674.205611214434;5681.573881958829;5684.602077854552;5700.201971723962;4073.3279008963486;4089.427480152781;4108.623611090288;4112.424260603518;4115.259253334429;5860.472557469806;5862.20860183874;5867.677277749722;5877.177195192634;5888.263967004124;4145.834166633361;4208.853484722814;4235.428217190702;4237.110206856594;4248.532661407243;4180.979095104505;4225.64082053029;4233.301505251599;4253.404523366731;4259.61663450291;4772.253780782069;4810.11012962603;4816.771723210559;4834.307992202771;4835.646019114653;5483.890322193533;5699.287589051369;5720.570957178228;5739.827805165852;5745.798897038583;1440.3734375546671;1458.7593047147313;1461.3643065266642;1465.6042868425466;1467.9266036698123;895.7414832160824;931.4411353188033;933.7292185266197;940.7554035950566;956.1155930764015;4806.206975848946;4816.470188279286;4864.610831133501;4890.559849613552;4898.853034408973;5156.535911767884;5156.61325400589;5188.610854185951;5253.9019564739565;5280.287161233261;4652.395188625457;4855.854324370274;4857.635677324215;4913.901721965541;4930.921151214255;2738.6302849115514;2757.26932362924;2768.9893188985875;2777.6250206222307;2779.555271156605;5284.591438522131;5292.285541451932;5325.973370133124;5342.572594192456;5369.5972802040005;4897.159647404497;5153.793848246103;5178.275041494194;5257.684538927677;5269.762860671279;5181.740912954338;5188.896222075613;5209.765560549708;5228.843134705965;5296.841094767163;5096.745162741922;5126.769575301826;5146.301720432323;5178.591954741063;5200.921986170135;4781.713097214179;5001;5022.920072184352;5027.597792176544;5088.0587091388215;5200.453952335101;5225.869353266199;5262.500062494057;5310.867228319323;5317.627766056339;3793.098279815998;3987.700922430887;4023.2959232134845;4081.387791831249;4111.424400583861;5797.942020579909;5808.473314108376;5809.651420914759;5818.418158184148;5822.7670893163795;5523.392426832965;5589.245451864109;5631.774729010794;5654.688992105309;5708.200851880823;5627.662340259434;5627.8593035174445;5628.1708444754795;5638.21065050885;5685.60200785941;5638.379778224474;5645.983722929748;5648.181013753065;5679.176519404746;5715.542756579381;5536.52939500147;5651.943480565306;5698.287714035746;5724.656520608777;5748.649067469058;5552.167174923794;5571.693556854412;5587.497125258747;5606.6916319602815;5613.831585052455 07:55:50 INFO - PROCESS | 8566 | |5;yui.html;654.6644844517183;658.23973310826;694.8228201808545;730.6931088942644;741.2994719989612;13228.27244501552;14027.158370497764;14430.71138577229;15514.689706205869;15742.921285393586;13663.863361366384;13965.860341396608;14180.787288190686;14184.21986790726;14190.929045354784;785.0500893918365;801.7113839017949;810.7567729681101;812.1391325195283;813.5200231863199;763.0995425398056;814.6700586262543;818.2104269380047;822.48183644304;822.6627082896014;856.0326830681353;856.4518708026836;857.2499063319596;860.0754189246554;861.6897916749965;850.2602735619988;851.1063383447417;851.3912552524944;851.4763420496381;854.465958775762;623.5541587764725;626.7493002798872;628.3245511075612;628.6008384675719;629.7197747002585;14707.63230919225;15100.622484437867;15154.545363639108;15200.239988000556;15223.238838058052;12671.303078330688;12762;12949.676258093528;13087.934560327138;13429.194248345131;10777.730556736144;10962.958518940688;11087.279326843729;11144.164187685956;11263.042641375492;3678.558572971234;3730.9067273318115;3791.8672846450518;3812.923741525182;3899;59271.703641481945;60170.69914650399;60596.69701651508;60777;62318.376816232165;9791.167750741266;10075.143612792848;10079.395236285847;10126;10487.580496780196;19211.135498902582;19505.707414388795;19653.41039768809;19742.40772776819;19757.506062348555;7536.962315188389;7778.416618753616;7800.843983120306;7891.802704932423;7983.12185659577;4260.25445547028;4416.646668266595;4443.0669559392245;4479.865604031885;4492.213862574036;3273.4435146025235;3380.915477113092;3382.424987752088;3394.728421726256;3400.4559270517093;564.3284491455155;566.5552541255095;573.7160105747681;575.720775423919;575.824373566058;529.317180836724;544.6024402186426;547.9808206712746;551.892380985712;560.5991715923135;8385.203405676451;8528.701495447754;8764.956175219084;9079.273658107335;9157.175854173156;549.670197881268;589.5107061139244;618.2951435363689;635.7774778827466;660.4353277947382;3771.4342848572933;4049.53430355507;4146.958530414718;4241.34259189826;4381.408509851193;54597.45402546003;56513.71743141258;56517.43482565204;70657.64671176611;86252.56873715592;71236;74460;78548.21451785523;78854.605726971;78863.21136788558;67501.66249168722;68525;70169.64915175493;70237.29762702409;70845.64577177081;9281.72154835356;9491.572879220314;9496;9603.327767056518;9640;44864.32703509385;45323.77338113288;45921;46471.53528464672;46922.53077469182;57626.7118664404;59659.70170149121;64695;65221;65353.67323163354;11973.820392693942;12048;12204.511819527119;12406.88886135547;12540.686482838002;13073;13302;13332.466701332227;13524.526641567498;13567.253801041037;11539.4807233673;11716.297022178696;11777.175597708077;12284.38578071075;12820.679483013;11341.149413793833;11736.178467507192;11762.470688818852;11874.168808183344;12241.326727030098;11867.169298149047;12019.699507512381;12205.877941220475;12223.388830558259;12350.3824808761;9487.478188699688;9680;10105.242106842163;10287.279890407599;10363.844542332023;10455.94772026135;10868.239223254297;10944.069754070993;10983.340999540053;11037.392943388191 07:55:50 INFO - PROCESS | 8566 | __end_tp_report 07:55:50 INFO - PROCESS | 8566 | __start_cc_report 07:55:50 INFO - PROCESS | 8566 | _x_x_mozilla_cycle_collect,318 07:55:50 INFO - PROCESS | 8566 | __end_cc_report 07:55:50 INFO - PROCESS | 8566 | __startTimestamp1477839350417__endTimestamp 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | ------- Summary: start ------- 07:55:50 INFO - PROCESS | 8566 | Number of tests: 6 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#0] dojo.html Cycles:165 Average:5489.41 Median:5725.46 stddev:645.58 (11.3%) stddev-sans-first:619.16 07:55:50 INFO - PROCESS | 8566 | Values: 3075.1 3075.9 3087.4 3093.8 3096.6 5375.4 5471.3 5502.6 5513.2 5542.5 5429.2 5486.2 5532.3 5576.1 5617.1 4987.6 5008.9 5031.3 5038.6 5087.6 5049.2 5133.4 5174.3 5175.2 5228.7 4886.8 5045.5 5077.3 5080.1 5093.7 4904.0 4945.1 4949.3 5002.2 5075.7 4929.7 4950.5 4961.0 4989.9 5032.6 5441.3 5489.6 5503.3 5515.6 5530.4 5748.7 5778.1 5786.9 5849.3 5875.1 5962.4 5968.0 5991.9 6013.8 6022.9 5552.9 5555.1 5560.3 5570.0 5571.6 5929.4 5938.8 5959.4 6072.6 6093.9 5753.1 5812.3 5853.6 5908.6 5920.0 5924.8 5926.1 5926.2 5928.6 5936.0 5668.3 5720.5 5845.0 5857.9 5877.8 5923.0 5923.7 5928.3 5929.2 5995.3 4492.1 4492.9 4502.4 4502.5 4557.7 3928.5 3941.1 3981.9 3992.9 4024.0 5675.8 5685.8 5753.3 5753.8 5754.2 5909.8 5989.1 6000.5 6014.0 6019.4 5522.2 5570.4 5695.9 5700.9 5701.4 4951.8 4977.3 4979.5 5007.8 5018.9 6096.0 6154.2 6167.9 6169.8 6170.5 5814.8 5959.8 5960.4 5967.4 5992.1 5998.4 6073.5 6116.5 6126.5 6145.7 5785.0 5798.4 5812.4 5838.4 5904.4 5929.6 5968.0 5973.4 5976.2 5986.3 5579.8 5645.1 5666.4 5725.5 5727.5 5729.9 5755.5 5758.1 5759.1 5761.9 5690.4 5718.5 5746.7 5751.9 5756.4 5732.4 5811.0 5854.4 5858.7 5936.1 5701.2 5712.8 5723.5 5756.2 5758.1 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#1] ext.html Cycles:180 Average:56884.75 Median:40926.59 stddev:107274.21 (262.1%) stddev-sans-first:107491.80 07:55:50 INFO - PROCESS | 8566 | Values: 567.3 574.0 581.8 594.6 605.1 38914.8 43748.0 43780.3 43846.3 43903.0 44028.3 44574.8 44613.8 44640.6 44642.3 8602.6 8685.0 8743.9 8747.9 8802.6 8665.3 8742.9 8755.6 8774.6 8781.7 8722.0 8763.7 8784.7 8800.7 8861.9 8720.7 8745.0 8811.2 8815.6 8816.7 8584.3 8597.3 8606.9 8673.7 8677.3 41815.4 42168.6 42200.8 42296.6 42324.6 2979.9 3163.3 3308.6 3463.9 3514.3 31048.4 31325.2 31857.8 31898.4 31899.7 3634.7 3675.1 3772.3 3856.0 3886.5 336471.0 338083.0 339598.0 341877.0 342829.0 57426.4 57464.7 57839.4 58281.6 58347.0 60192.4 60256.4 60289.7 60355.7 60565.7 15432.5 15675.2 15708.2 15820.5 15927.0 11288.4 11340.4 11394.0 11440.9 11478.6 16144.4 16366.6 16399.1 16411.6 16823.7 6725.4 6859.7 6874.7 6907.0 7037.8 936.8 991.5 1064.5 1098.1 1134.0 31158.0 31423.5 32220.4 32823.8 33018.0 1095.2 1109.7 1131.2 1136.9 1185.8 16130.0 16939.7 16959.7 16982.6 17099.7 496218.0 499578.0 499747.0 500184.0 500380.0 56852.4 56943.1 57386.0 57435.4 57520.7 1283.2 1303.3 1350.1 1351.5 1365.3 29425.6 30938.2 31673.4 31853.0 32096.4 51110.5 51752.0 51973.7 51985.0 52062.2 358182.0 360115.0 360793.0 361188.0 361380.0 40164.2 40263.0 40853.6 40941.0 41116.0 46652.3 47301.5 47833.5 49505.8 49669.5 38318.6 39824.2 40007.8 40625.4 41364.0 39608.8 40912.2 41474.4 41668.4 41927.4 40308.8 40560.0 40853.6 41610.2 41717.0 32409.7 35062.1 35874.6 36487.1 36875.4 28302.0 28476.3 28520.7 28583.7 28594.9 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#2] jquery.html Cycles:180 Average:26288.11 Median:199072.81 stddev:67474.46 (33.9%) stddev-sans-first:67635.71 07:55:50 INFO - PROCESS | 8566 | Values: 383.5 390.8 391.2 399.6 418.6 17948.9 19085.5 19516.9 19557.0 19844.2 17444.7 17553.7 17864.3 17933.7 18190.9 5403.4 5471.7 5636.8 5652.5 5737.3 5656.9 5676.2 5690.2 5699.2 5700.8 5600.7 5653.0 6012.8 6423.9 6444.9 6264.3 6439.4 6443.3 6473.9 6519.3 5460.2 5519.4 5532.5 5542.8 5581.1 12924.4 12991.8 12991.9 13126.6 13202.1 2195.6 2360.6 2363.6 2422.6 2437.9 9266.4 9449.5 9617.5 9861.4 10015.7 1897.2 1935.8 1939.5 1997.0 2009.6 83190.6 83308.6 84070.0 84981.6 86206.0 10383.9 10551.0 10591.6 11119.1 11163.0 15197.0 15291.8 15309.4 15321.7 15359.2 7353.9 7573.7 7630.0 7794.7 7902.9 7177.4 7302.4 7305.6 7514.9 7524.8 4289.5 4313.5 4451.8 4565.1 4598.6 1936.7 1954.5 1986.0 1986.7 2013.2 900.6 951.7 956.5 1035.6 1066.4 18468.0 18680.7 18992.4 19147.3 19490.5 962.9 976.9 981.0 1009.8 1024.2 9930.5 10350.0 10409.7 11000.7 11156.4 397746.0 400215.0 405944.0 407618.0 411856.0 92868.5 93035.5 94138.5 94156.0 94614.5 1041.2 1048.8 1082.7 1092.7 1098.7 16126.6 17015.0 17229.9 17241.2 17678.7 40628.8 41603.8 41681.0 42533.0 42964.0 54859.7 55662.4 56702.4 57076.0 59524.7 6702.5 7192.4 8117.8 8175.5 8286.8 9215.7 12682.3 13085.9 13227.3 13241.2 11532.3 11567.3 11574.8 11636.8 11900.7 11380.0 11417.5 11465.8 11483.9 11602.7 11425.3 11612.5 11665.1 11689.7 12113.3 8104.2 8198.3 8276.8 8360.2 8423.0 9140.3 11157.6 11440.8 11625.8 12174.3 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#3] mootools.html Cycles:180 Average:5567.92 Median:5006.00 stddev:3155.76 (63.0%) stddev-sans-first:3149.60 07:55:50 INFO - PROCESS | 8566 | Values: 1472.5 1485.1 1615.6 1719.4 1757.5 7295.9 7515.4 8113.8 8667.4 8668.2 8126.3 8391.7 8402.5 8604.7 8637.6 2312.5 2327.1 2327.7 2332.2 2338.0 2296.3 2335.4 2338.7 2338.8 2342.7 2277.3 2278.6 2306.6 2313.9 2330.2 2249.4 2249.6 2260.0 2260.2 2266.1 2239.8 2254.3 2255.2 2257.9 2263.8 8443.7 8524.1 8563.0 8605.5 8617.1 5001.9 5109.1 5141.9 5176.0 5185.7 3141.6 3227.6 3442.9 3482.8 3505.8 1088.0 1107.5 1113.5 1119.9 1171.8 11744.5 11889.6 11889.8 11910.9 11940.8 4341.2 4625.4 4701.6 4704.1 4721.2 9742.1 9873.1 9902.5 9908.4 9952.5 5118.0 5148.5 5158.0 5165.6 5179.2 4003.1 4131.3 4556.7 4667.5 4702.6 3804.6 3813.3 3874.4 3889.9 3911.3 1264.1 1273.9 1274.1 1288.8 1300.7 784.4 942.2 950.5 951.4 965.1 5766.0 5802.1 5826.0 5839.6 5891.6 428.6 430.1 431.1 453.5 458.4 3832.5 3899.2 3920.2 3951.1 3965.1 10171.2 10712.0 10713.3 10719.4 10727.4 10304.5 10437.7 10502.6 10530.6 10543.5 7911.6 7933.8 7943.7 8030.2 8084.1 5632.9 5755.9 5777.8 5814.3 5855.4 9457.0 9459.1 9507.7 9570.3 9623.8 9636.7 9751.8 9766.5 9808.9 9834.6 6260.9 6490.9 6963.9 7141.7 7209.6 7855.5 8173.9 8218.5 8222.9 8228.6 7371.9 7376.0 7486.6 7567.3 7652.9 7140.1 7318.2 7331.6 7364.5 7380.9 6703.7 6793.8 6801.9 6814.6 6815.3 4822.2 4876.6 4930.3 4930.5 5010.1 4840.1 5013.4 5013.6 5026.9 5101.1 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#4] prototype.html Cycles:180 Average:4608.69 Median:5156.57 stddev:1320.72 (25.6%) stddev-sans-first:1284.71 07:55:50 INFO - PROCESS | 8566 | Values: 325.7 332.8 339.4 342.6 342.8 5353.8 5459.4 5523.6 5597.9 5640.2 5231.4 5333.4 5353.4 5354.3 5382.0 4207.7 4209.5 4222.7 4252.8 4264.9 4217.3 4249.9 4251.6 4268.3 4288.9 4212.2 4233.1 4244.1 4246.7 4251.9 4245.9 4253.8 4266.3 4269.4 4269.5 3700.2 3790.8 3812.6 3815.5 3815.9 5326.5 5329.9 5340.3 5355.1 5397.9 4853.4 4878.0 4888.3 4905.6 4916.2 5565.4 5674.2 5681.6 5684.6 5700.2 4073.3 4089.4 4108.6 4112.4 4115.3 5860.5 5862.2 5867.7 5877.2 5888.3 4145.8 4208.9 4235.4 4237.1 4248.5 4181.0 4225.6 4233.3 4253.4 4259.6 4772.3 4810.1 4816.8 4834.3 4835.6 5483.9 5699.3 5720.6 5739.8 5745.8 1440.4 1458.8 1461.4 1465.6 1467.9 895.7 931.4 933.7 940.8 956.1 4806.2 4816.5 4864.6 4890.6 4898.9 5156.5 5156.6 5188.6 5253.9 5280.3 4652.4 4855.9 4857.6 4913.9 4930.9 2738.6 2757.3 2769.0 2777.6 2779.6 5284.6 5292.3 5326.0 5342.6 5369.6 4897.2 5153.8 5178.3 5257.7 5269.8 5181.7 5188.9 5209.8 5228.8 5296.8 5096.7 5126.8 5146.3 5178.6 5200.9 4781.7 5001.0 5022.9 5027.6 5088.1 5200.5 5225.9 5262.5 5310.9 5317.6 3793.1 3987.7 4023.3 4081.4 4111.4 5797.9 5808.5 5809.7 5818.4 5822.8 5523.4 5589.2 5631.8 5654.7 5708.2 5627.7 5627.9 5628.2 5638.2 5685.6 5638.4 5646.0 5648.2 5679.2 5715.5 5536.5 5651.9 5698.3 5724.7 5748.6 5552.2 5571.7 5587.5 5606.7 5613.8 07:55:50 INFO - PROCESS | 8566 | 07:55:50 INFO - PROCESS | 8566 | [#5] yui.html Cycles:180 Average:16881.79 Median:46697.03 stddev:21893.64 (46.9%) stddev-sans-first:21921.15 07:55:50 INFO - PROCESS | 8566 | Values: 654.7 658.2 694.8 730.7 741.3 13228.3 14027.2 14430.7 15514.7 15742.9 13663.9 13965.9 14180.8 14184.2 14190.9 785.1 801.7 810.8 812.1 813.5 763.1 814.7 818.2 822.5 822.7 856.0 856.5 857.2 860.1 861.7 850.3 851.1 851.4 851.5 854.5 623.6 626.7 628.3 628.6 629.7 14707.6 15100.6 15154.5 15200.2 15223.2 12671.3 12762.0 12949.7 13087.9 13429.2 10777.7 10963.0 11087.3 11144.2 11263.0 3678.6 3730.9 3791.9 3812.9 3899.0 59271.7 60170.7 60596.7 60777.0 62318.4 9791.2 10075.1 10079.4 10126.0 10487.6 19211.1 19505.7 19653.4 19742.4 19757.5 7537.0 7778.4 7800.8 7891.8 7983.1 4260.3 4416.6 4443.1 4479.9 4492.2 3273.4 3380.9 3382.4 3394.7 3400.5 564.3 566.6 573.7 575.7 575.8 529.3 544.6 548.0 551.9 560.6 8385.2 8528.7 8765.0 9079.3 9157.2 549.7 589.5 618.3 635.8 660.4 3771.4 4049.5 4147.0 4241.3 4381.4 54597.5 56513.7 56517.4 70657.6 86252.6 71236.0 74460.0 78548.2 78854.6 78863.2 67501.7 68525.0 70169.6 70237.3 70845.6 9281.7 9491.6 9496.0 9603.3 9640.0 44864.3 45323.8 45921.0 46471.5 46922.5 57626.7 59659.7 64695.0 65221.0 65353.7 11973.8 12048.0 12204.5 12406.9 12540.7 13073.0 13302.0 13332.5 13524.5 13567.3 11539.5 11716.3 11777.2 12284.4 12820.7 11341.1 11736.2 11762.5 11874.2 12241.3 11867.2 12019.7 12205.9 12223.4 12350.4 9487.5 9680.0 10105.2 10287.3 10363.8 10455.9 10868.2 10944.1 10983.3 11037.4 07:55:50 INFO - PROCESS | 8566 | -------- Summary: end -------- 07:55:50 INFO - PROCESS | 8566 | 07:55:51 INFO - TEST-INFO | 8566: exit 0 07:55:51 INFO - TEST-OK | dromaeo_css | took 1115288ms 07:55:51 INFO - TEST-START | kraken 07:55:51 INFO - operating with platform_type : linux_ 07:55:51 INFO - Initialising browser for kraken test... 07:55:51 INFO - TEST-INFO | started process 8920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW24nIu/profile http://localhost:50036/getInfo.html) 07:55:55 INFO - PROCESS | 8920 | __metrics Screen width/height:1600/1200 07:55:55 INFO - PROCESS | 8920 | colorDepth:24 07:55:55 INFO - PROCESS | 8920 | Browser inner width/height: 1024/697 07:55:55 INFO - PROCESS | 8920 | __metrics 07:55:56 ERROR - PROCESS | 8920 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 07:55:57 INFO - TEST-INFO | 8920: exit 0 07:55:57 INFO - Browser initialized. 07:55:57 INFO - Running cycle 1/1 for kraken test... 07:55:57 INFO - TEST-INFO | started process 9040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW24nIu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:09 INFO - PROCESS | 9040 | RSS: Main: 185450496 07:56:09 INFO - PROCESS | 9040 | 07:56:12 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50036/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:12 INFO - PROCESS | 9040 | RSS: Main: 198709248 07:56:12 INFO - PROCESS | 9040 | 07:56:15 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50036/tests/kraken/driver.html?testName=audio-dft) 07:56:16 INFO - PROCESS | 9040 | RSS: Main: 196722688 07:56:16 INFO - PROCESS | 9040 | 07:56:19 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50036/tests/kraken/driver.html?testName=audio-fft) 07:56:19 INFO - PROCESS | 9040 | RSS: Main: 193150976 07:56:19 INFO - PROCESS | 9040 | 07:56:21 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50036/tests/kraken/driver.html?testName=audio-oscillator) 07:56:22 INFO - PROCESS | 9040 | RSS: Main: 193757184 07:56:22 INFO - PROCESS | 9040 | 07:56:24 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50036/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:25 INFO - PROCESS | 9040 | RSS: Main: 193896448 07:56:25 INFO - PROCESS | 9040 | 07:56:28 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50036/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:28 INFO - PROCESS | 9040 | RSS: Main: 194101248 07:56:28 INFO - PROCESS | 9040 | 07:56:32 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50036/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:32 INFO - PROCESS | 9040 | RSS: Main: 194269184 07:56:32 INFO - PROCESS | 9040 | 07:56:35 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50036/tests/kraken/driver.html?testName=json-parse-financial) 07:56:36 INFO - PROCESS | 9040 | RSS: Main: 193667072 07:56:36 INFO - PROCESS | 9040 | 07:56:37 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50036/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:38 INFO - PROCESS | 9040 | RSS: Main: 193785856 07:56:38 INFO - PROCESS | 9040 | 07:56:40 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:41 INFO - PROCESS | 9040 | RSS: Main: 193675264 07:56:41 INFO - PROCESS | 9040 | 07:56:43 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:56:43 INFO - PROCESS | 9040 | RSS: Main: 194211840 07:56:43 INFO - PROCESS | 9040 | 07:56:46 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:56:47 INFO - PROCESS | 9040 | RSS: Main: 194342912 07:56:47 INFO - PROCESS | 9040 | 07:56:50 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:56:50 INFO - PROCESS | 9040 | RSS: Main: 194441216 07:56:50 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | Cycle 1(1): loaded http://localhost:50036/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50036/tests/kraken/driver.html?testName=ai-astar) 07:56:52 INFO - PROCESS | 9040 | RSS: Main: 196018176 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | __start_tp_report 07:56:52 INFO - PROCESS | 9040 | _x_x_mozilla_page_load 07:56:52 INFO - PROCESS | 9040 | _x_x_mozilla_page_load_details 07:56:52 INFO - PROCESS | 9040 | |i|pagename|runs| 07:56:52 INFO - PROCESS | 9040 | |0;ai-astar;106;115;114;114;115;113;113;114;112;112 07:56:52 INFO - PROCESS | 9040 | |1;audio-beat-detection;152;124;126;173;125;132;127;125;152;126 07:56:52 INFO - PROCESS | 9040 | |2;audio-dft;162;172;165;176;163;163;164;163;162;163 07:56:52 INFO - PROCESS | 9040 | |3;audio-fft;74;77;76;112;79;76;76;76;98;76 07:56:52 INFO - PROCESS | 9040 | |4;audio-oscillator;83;82;113;83;82;83;100;82;84;112 07:56:52 INFO - PROCESS | 9040 | |5;imaging-gaussian-blur;118;119;118;118;118;118;117;118;117;118 07:56:52 INFO - PROCESS | 9040 | |6;imaging-darkroom;147;150;147;147;147;146;146;148;147;147 07:56:52 INFO - PROCESS | 9040 | |7;imaging-desaturate;84;86;86;85;85;85;85;84;88;85 07:56:52 INFO - PROCESS | 9040 | |8;json-parse-financial;54;57;56;56;57;56;60;54;56;55 07:56:52 INFO - PROCESS | 9040 | |9;json-stringify-tinderbox;61;62;61;63;63;62;61;62;65;62 07:56:52 INFO - PROCESS | 9040 | |10;stanford-crypto-aes;80;85;80;86;80;80;79;80;80;86 07:56:52 INFO - PROCESS | 9040 | |11;stanford-crypto-ccm;146;135;142;146;136;130;141;131;168;145 07:56:52 INFO - PROCESS | 9040 | |12;stanford-crypto-pbkdf2;164;164;162;166;166;167;166;164;168;164 07:56:52 INFO - PROCESS | 9040 | |13;stanford-crypto-sha256-iterative;63;65;65;65;65;65;72;71;63;63 07:56:52 INFO - PROCESS | 9040 | __end_tp_report 07:56:52 INFO - PROCESS | 9040 | __start_cc_report 07:56:52 INFO - PROCESS | 9040 | _x_x_mozilla_cycle_collect,809 07:56:52 INFO - PROCESS | 9040 | __end_cc_report 07:56:52 INFO - PROCESS | 9040 | __startTimestamp1477839412598__endTimestamp 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ------- Summary: start ------- 07:56:52 INFO - PROCESS | 9040 | Number of tests: 14 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:2.62 (2.3%) stddev-sans-first:1.13 07:56:52 INFO - PROCESS | 9040 | Values: 106.0 115.0 114.0 114.0 115.0 113.0 113.0 114.0 112.0 112.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:129.50 stddev:16.88 (13.0%) stddev-sans-first:16.90 07:56:52 INFO - PROCESS | 9040 | Values: 152.0 124.0 126.0 173.0 125.0 132.0 127.0 125.0 152.0 126.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#2] audio-dft Cycles:10 Average:165.30 Median:163.50 stddev:4.76 (2.9%) stddev-sans-first:4.90 07:56:52 INFO - PROCESS | 9040 | Values: 162.0 172.0 165.0 176.0 163.0 163.0 164.0 163.0 162.0 163.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.62 (16.6%) stddev-sans-first:13.05 07:56:52 INFO - PROCESS | 9040 | Values: 74.0 77.0 76.0 112.0 79.0 76.0 76.0 76.0 98.0 76.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.50 stddev:12.85 (15.6%) stddev-sans-first:13.35 07:56:52 INFO - PROCESS | 9040 | Values: 83.0 82.0 113.0 83.0 82.0 83.0 100.0 82.0 84.0 112.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:56:52 INFO - PROCESS | 9040 | Values: 118.0 119.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 118.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.14 (0.8%) stddev-sans-first:1.20 07:56:52 INFO - PROCESS | 9040 | Values: 147.0 150.0 147.0 147.0 147.0 146.0 146.0 148.0 147.0 147.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:1.16 (1.4%) stddev-sans-first:1.13 07:56:52 INFO - PROCESS | 9040 | Values: 84.0 86.0 86.0 85.0 85.0 85.0 85.0 84.0 88.0 85.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.73 (3.1%) stddev-sans-first:1.66 07:56:52 INFO - PROCESS | 9040 | Values: 54.0 57.0 56.0 56.0 57.0 56.0 60.0 54.0 56.0 55.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:1.23 (2.0%) stddev-sans-first:1.22 07:56:52 INFO - PROCESS | 9040 | Values: 61.0 62.0 61.0 63.0 63.0 62.0 61.0 62.0 65.0 62.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.00 stddev:2.84 (3.5%) stddev-sans-first:2.95 07:56:52 INFO - PROCESS | 9040 | Values: 80.0 85.0 80.0 86.0 80.0 80.0 79.0 80.0 80.0 86.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:143.50 stddev:10.89 (7.6%) stddev-sans-first:11.46 07:56:52 INFO - PROCESS | 9040 | Values: 146.0 135.0 142.0 146.0 136.0 130.0 141.0 131.0 168.0 145.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:166.00 stddev:1.79 (1.1%) stddev-sans-first:1.86 07:56:52 INFO - PROCESS | 9040 | Values: 164.0 164.0 162.0 166.0 166.0 167.0 166.0 164.0 168.0 164.0 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.00 stddev:3.20 (4.9%) stddev-sans-first:3.24 07:56:52 INFO - PROCESS | 9040 | Values: 63.0 65.0 65.0 65.0 65.0 65.0 72.0 71.0 63.0 63.0 07:56:52 INFO - PROCESS | 9040 | -------- Summary: end -------- 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | 07:56:52 INFO - PROCESS | 9040 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 07:56:52 INFO - PROCESS | 9040 | 07:56:53 INFO - TEST-INFO | 9040: exit 0 07:56:53 INFO - TEST-OK | kraken | took 62409ms 07:56:53 INFO - SUITE-END | took 1177s 07:56:54 INFO - Completed test suite (00:19:38) 07:56:54 INFO - javascript benchmark 07:56:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7026.827889656859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3075.0774767569724, 3075.9384812303742, 3087.397957398307, 3093.8298393588357, 3096.6284045914495, 5375.43557926418, 5471.316085489314, 5502.58730595205, 5513.2005859150395, 5542.473465020827, 5429.158480435539, 5486.177073438987, 5532.2531458253125, 5576.052071147905, 5617.101263797793, 4987.625928055401, 5008.874778130539, 5031.32077169581, 5038.5969122470115, 5087.6184286178495, 5049.24261360797, 5133.409657889353, 5174.327337446127, 5175.24958880962, 5228.660137091077, 4886.755662216875, 5045.495450454925, 5077.314562534048, 5080.1363768159135, 5093.719845408501, 4903.975480122613, 4945.134601444769, 4949.257611358289, 5002.224655178453, 5075.720835354054, 4929.65492415531, 4950.504949505021, 4960.950390496085, 4989.90020199594, 5032.572231360302, 5441.265429167091, 5489.643173193769, 5503.3395992481155, 5515.586331025149, 5530.446955304477, 5748.7125643717645, 5778.104393818923, 5786.942130578683, 5849.298084229919, 5875.118732190205, 5962.373950735154, 5968.0, 5991.850203744898, 6013.849653758647, 6022.939770602326, 5552.888942221173, 5555.055640541118, 5560.304961879765, 5570.025245582047, 5571.637843540157, 5929.37741537141, 5938.762449502058, 5959.433853783884, 6072.574919755575, 6093.878122437526, 5753.079507278815, 5812.273465816773, 5853.590248682552, 5908.586398952032, 5919.970400147971, 5924.763009479659, 5926.140709597171, 5926.1999630049395, 5928.584999050111, 5936.0, 5668.291463567054, 5720.48515633595, 5844.970775146097, 5857.853553661193, 5877.794277200277, 5922.970385148046, 5923.733431995571, 5928.258967629046, 5929.229200203946, 5995.250593675791, 4492.101579684077, 4492.910141797146, 4502.414686090853, 4502.527234640381, 4557.6581756368405, 3928.4500169976227, 3941.0541470046983, 3981.9402708959387, 3992.8802135935966, 4023.9597604023584, 5675.829725108253, 5685.829425117253, 5753.252077229933, 5753.769849206069, 5754.165645981309, 5909.763609455659, 5989.131575921467, 6000.519958403317, 6014.0, 6019.428154325332, 5522.22688823565, 5570.442955704478, 5695.857603559944, 5700.857478562986, 5701.372848986608, 4951.777170027357, 4977.32806071183, 4979.4771548987555, 5007.774650140753, 5018.89962200754, 6095.969520152371, 6154.1999540059505, 6167.938320616737, 6169.784057558054, 6170.475509581646, 5814.767409303749, 5959.761609535743, 5960.403959604005, 5967.403259673998, 5992.13114098462, 5998.430149135826, 6073.453389194994, 6116.510679145568, 6126.5098792097415, 6145.67867908384, 5785.0, 5798.391168927371, 5812.447817457335, 5838.4453476919625, 5904.3800400959, 5929.555283353852, 5968.045112781934, 5973.372795856546, 5976.19321391624, 5986.2517185351835, 5579.804706835242, 5645.125005624135, 5666.433356664301, 5725.456081672234, 5727.455891690282, 5729.8567535811935, 5755.510781583613, 5758.078707406795, 5759.107338362561, 5761.8559536011935, 5690.402507736628, 5718.456746609066, 5746.683932383759, 5751.884962300815, 5756.395578464369, 5732.426757324234, 5811.041178205718, 5854.443827836349, 5858.7070646466655, 5936.139259807217, 5701.230333905036, 5712.80005199816, 5723.542116630742, 5756.1941328214925, 5758.1362795581], "value": 5443.458447677215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.2965522751787, 574.0155633089254, 581.7876475086593, 594.5629961977949, 605.1467430922401, 38914.80542597287, 43748.0, 43780.3432948506, 43846.34230486545, 43903.0, 44028.33957490632, 44574.77712611432, 44613.77693111538, 44640.55359446404, 44642.33036504455, 8602.612882420306, 8684.956575217115, 8743.912560874405, 8747.912520874774, 8802.559872006406, 8665.263452606505, 8742.86885696715, 8755.562221888911, 8774.64901403943, 8781.692640757576, 8721.95639021804, 8763.737087887373, 8784.736457906272, 8800.691975780848, 8861.867071993925, 8720.651173953034, 8745.0, 8811.162939520735, 8815.559222038937, 8816.73549793504, 8584.27033702136, 8597.312215022846, 8606.913930860674, 8673.696420625249, 8677.305815534743, 41815.37276940848, 42168.57831421677, 42200.78899605482, 42296.57703422957, 42324.576754232374, 2979.865906034234, 3163.3040731039137, 3308.5698859148397, 3463.930721385583, 3514.3322768674125, 31048.379032419452, 31325.216869578217, 31857.84071079653, 31898.362032759447, 31899.681003189904, 3634.6910512606196, 3675.1363429594026, 3772.264408440355, 3856.0359910022494, 3886.4947556817715, 336471.0, 338083.0, 339598.0, 341876.9999999975, 342829.0, 57426.425735742945, 57464.71267643635, 57839.42160578424, 58281.63508115961, 58347.0, 60192.39807601868, 60256.39743602508, 60289.69855150784, 60355.69822150949, 60565.697171514745, 15432.459863904709, 15675.216239187996, 15708.21458927049, 15820.525384238492, 15927.0, 11288.435578221057, 11340.43297835105, 11394.0, 11440.885591143982, 11478.565179352581, 16144.434944776876, 16366.590835228977, 16399.064224586014, 16411.58971025734, 16823.747643785355, 6725.428338591177, 6859.657017149123, 6874.690638921161, 6907.0, 7037.753678621224, 936.7939053408239, 991.548845275398, 1064.5422468338534, 1098.0885864732254, 1134.0, 31158.0, 31423.528647070314, 32220.35559288848, 32823.83588082044, 33018.0, 1095.2059756676347, 1109.7170221593442, 1131.1742428027585, 1136.8806275341135, 1185.7569198314325, 16130.0, 16939.745903811454, 16959.745603815954, 16982.57543561421, 17099.74350384745, 496218.0, 499578.0, 499747.0, 500184.0, 500380.0, 56852.43147568554, 56943.14585281224, 57386.0, 57435.42564574301, 57520.71239643859, 1283.2108253424076, 1303.3483258370813, 1350.1089281074444, 1351.5472316773794, 1365.2900491744238, 29425.558616621194, 30938.226544336572, 31673.366532668755, 31852.9663803578, 32096.35807283888, 51110.488895110575, 51752.0, 51973.7401312991, 51985.0, 52062.219066713275, 358182.0, 360115.0, 360793.0, 361188.0, 361380.0, 40164.1967160661, 40263.0, 40853.59146408498, 40941.0, 41116.0, 46652.300215497475, 47301.52698473109, 47833.52166478291, 49505.752471237414, 49669.50330496793, 38318.61681383262, 39824.2035159301, 40007.79996100001, 40625.39061914015, 41364.0, 39608.801955990035, 40912.1817563653, 41474.37788433115, 41668.374974374805, 41927.37108943307, 40308.798456007535, 40560.0, 40853.59146408498, 41610.16779664329, 41717.0, 32409.675903240666, 35062.12344691403, 35874.64125358713, 36487.08782280464, 36875.44686829646, 28302.0, 28476.288092797844, 28520.714792851806, 28583.714162858105, 28594.857025714737], "value": 19732.75338668882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.50910834132304, 390.8182695046803, 391.22342150830616, 399.6183644619389, 418.62323908482364, 17948.910255448736, 19085.522861928457, 19516.90241548792, 19557.0, 19844.20623175071, 17444.738328925076, 17553.736693949602, 17864.285428582873, 17933.7309940351, 18190.909045454755, 5403.432639572838, 5471.671699698011, 5636.830895073133, 5652.491275785179, 5737.311522617292, 5656.858578535528, 5676.205331253628, 5690.174924635925, 5699.202111704365, 5700.828975130753, 5600.691961942091, 5653.038983372837, 6012.759489620432, 6423.93576064238, 6444.903326450107, 6264.27960784511, 6439.388258115471, 6443.323451037644, 6473.8705225895455, 6519.250286217099, 5460.235567020621, 5519.365272993617, 5532.474414930575, 5542.8337149885565, 5581.107022876361, 12924.353782310847, 12991.805122923164, 12991.935040324737, 13126.60620181396, 13202.141860779115, 2195.6267434536167, 2360.5750964826325, 2363.6218205087102, 2422.5639384910887, 2437.878106094688, 9266.351355405124, 9449.527523623792, 9617.51912404377, 9861.408315501092, 10015.74960625983, 1897.155765684271, 1935.7870634230223, 1939.486036200408, 1996.99001504993, 2009.6382651122792, 83190.58404708059, 83308.58345708232, 84070.0, 84981.57509212477, 86206.0, 10383.94808025955, 10551.0, 10591.57633694659, 11119.110471162288, 11163.0, 15197.0, 15291.847081529264, 15309.387624494895, 15321.693566128837, 15359.155246461329, 7353.852922941511, 7573.734919277909, 7630.0, 7794.6882124714375, 7902.920970790334, 7177.389921856597, 7302.415806735448, 7305.598192099379, 7514.924850751422, 7524.849503009909, 4289.549597292239, 4313.482382114166, 4451.816950880137, 4565.109803588269, 4598.563136502027, 1936.66108431024, 1954.491832123658, 1986.0069965017492, 1986.7218589397496, 2013.194722111138, 900.5677274908081, 951.6764300137847, 956.502618638318, 1035.5754140802235, 1066.3713945125303, 18468.0, 18680.719789203173, 18992.43022709321, 19147.329843455413, 19490.512737181685, 962.9374090684223, 976.9316147869723, 980.9901900981041, 1009.7728011197422, 1024.2062401638789, 9930.50347482623, 10350.0, 10409.68770936873, 11000.679918409682, 11156.442177891073, 397746.0, 400215.0, 405944.0, 407618.0, 411856.0, 92868.53565732263, 93035.53482232681, 94138.5293073544, 94156.0, 94614.5269273663, 1041.1670663469345, 1048.7692707604315, 1082.6697857153645, 1092.7158938676002, 1098.7363032872054, 16126.596835079217, 17015.0, 17229.91385043067, 17241.22414491376, 17678.734818977984, 40628.79685601553, 41603.79198104111, 41681.0, 42533.0, 42964.0, 54859.72570137124, 55662.44337556572, 56702.43297567136, 57076.0, 59524.70237648784, 6702.463802895659, 7192.352688258082, 8117.756467305991, 8175.509469431853, 8286.751397457845, 9215.677451289173, 12682.302473364054, 13085.869141308845, 13227.338633068115, 13241.205527667986, 11532.308061516336, 11567.305961642329, 11574.826377604511, 11636.76726465449, 11900.702482438008, 11380.0, 11417.543298267976, 11465.828012579985, 11483.885161148615, 11602.70993225176, 11425.31448113116, 11612.5354985803, 11665.075262581578, 11689.655689595806, 12113.273203607812, 8104.189581042085, 8198.262156405952, 8276.83446331082, 8360.244348686843, 8423.0, 9140.314476414429, 11157.553697851996, 11440.82838757436, 11625.825612615648, 12174.269543827399], "value": 8916.574157164716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1472.4772705689477, 1485.1386196006315, 1615.5557221764013, 1719.3724290633916, 1757.4727581725494, 7295.890561641566, 7515.361194298491, 8113.756587302383, 8667.436616619916, 8668.176523230299, 8126.309263712592, 8391.706290279826, 8402.453840500364, 8604.741857744277, 8637.568121593926, 2312.5490529346785, 2327.1273272522803, 2327.697399338092, 2332.242021343062, 2338.0, 2296.334063121693, 2335.439494521311, 2338.707661542307, 2338.7895089441945, 2342.7188737351457, 2277.339571524256, 2278.5556816420803, 2306.6194077977198, 2313.9305820825316, 2330.1611419888827, 2249.3589327041714, 2249.5613355395703, 2259.9774002259933, 2260.175036111824, 2266.0935625749667, 2239.8096161826265, 2254.3462395905167, 2255.154317131076, 2257.932262032142, 2263.7849404306567, 8443.70447034357, 8524.062353141211, 8563.0, 8605.483670979762, 8617.052124266325, 5001.874953126165, 5109.105906466353, 5141.897162056738, 5175.974120129413, 5185.714785686786, 3141.5915930929064, 3227.6288226853976, 3442.913927151816, 3482.7736197147356, 3505.789652620851, 1087.994560027195, 1107.4739498738036, 1113.4766659669942, 1119.8880111988817, 1171.8242263660434, 11744.471498782576, 11889.643310700692, 11889.762204755943, 11910.940445297805, 11940.820887686605, 4341.153475072394, 4625.398698169217, 4701.600363969101, 4704.082703872712, 4721.197396442613, 9742.123208911233, 9873.062059104373, 9902.504874756234, 9908.35595686278, 9952.452615106095, 5118.0, 5148.536631703165, 5157.974210128926, 5165.638405311592, 5179.171332586768, 4003.099302656937, 4131.29767939445, 4556.658250631216, 4667.486576476653, 4702.553257440538, 3804.619538046173, 3813.2754776592915, 3874.438206460104, 3889.902752431212, 3911.3350730375905, 1264.1467009768553, 1273.936303184837, 1274.1081243129847, 1288.8324517812625, 1300.655326338521, 784.4469648897514, 942.2273735536932, 950.5247376311844, 951.3578334624101, 965.0542468381026, 5765.971170144123, 5802.1296805479515, 5825.970870145707, 5839.620424672467, 5891.646501209942, 428.5628658768039, 430.07104653947323, 431.11190946650004, 453.5238000099882, 458.37889659511546, 3832.5017747692623, 3899.161680238762, 3920.1963597463023, 3951.091249012743, 3965.0682089708894, 10171.186305095574, 10712.0, 10713.250072495006, 10719.410432426292, 10727.356358618508, 10304.484775761182, 10437.686869393778, 10502.632407865687, 10530.63142790014, 10543.472826358651, 7911.564863932539, 7933.801654958672, 7943.682252709827, 8030.156833532512, 8084.1107478177355, 5632.85917852057, 5755.8561035974435, 5777.768889244551, 5814.30228372598, 5855.443732845373, 9456.952715236379, 9459.148676618863, 9507.66723164686, 9570.33007689455, 9623.807523849624, 9636.71089867305, 9751.804963900824, 9766.46284454362, 9808.852867206855, 9834.557444914853, 6260.874782504416, 6490.935090649033, 6963.93036069653, 7141.714331426685, 7209.6034718091005, 7855.450118491651, 8173.918260817553, 8218.465799722999, 8222.876656850272, 8228.588570571566, 7371.852562948819, 7375.963120184365, 7486.5508069516, 7567.31894129531, 7652.923470765444, 7140.107486564179, 7318.231585683427, 7331.596762178131, 7364.484486085923, 7380.889286660812, 6703.698333574904, 6793.796186114425, 6801.863962720817, 6814.557053791487, 6815.318468153343, 4822.156122678587, 4876.561109500162, 4930.260460930889, 4930.531599498042, 5010.123228434936, 4840.1287768200655, 5013.373328333958, 5013.649044566845, 5026.949730502648, 5101.132807422821], "value": 4407.301540160769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.74591818381657, 332.78701630956186, 339.37554898985894, 342.58889332800646, 342.81316682408095, 5353.812616558412, 5459.3994660587305, 5523.6409633373805, 5597.888042239158, 5640.238567793347, 5231.352124080921, 5333.399980006002, 5353.384360798509, 5354.2771725817, 5381.973090134554, 4207.663386929038, 4209.47431541076, 4222.74663520189, 4252.766097864632, 4264.893377665552, 4217.261979153651, 4249.915001699964, 4251.5960983706655, 4268.317069268917, 4288.914221715564, 4212.178625168093, 4233.1322078973735, 4244.0663054128045, 4246.662301375057, 4251.914961700764, 4245.851395201169, 4253.80857861397, 4266.33354153654, 4269.380939763717, 4269.487661480643, 3700.204456041964, 3790.8294126764363, 3812.5996770338993, 3815.5421349437966, 3815.8855234343014, 5326.520613144836, 5329.9467005330225, 5340.25236466895, 5355.116405793039, 5397.865053373658, 4853.3690620219495, 4877.975610121962, 4888.315635810989, 4905.626424601118, 4916.164252077119, 5565.387807341189, 5674.205611214434, 5681.573881958829, 5684.602077854552, 5700.201971723962, 4073.3279008963486, 4089.427480152781, 4108.623611090288, 4112.424260603518, 4115.259253334429, 5860.472557469806, 5862.20860183874, 5867.677277749722, 5877.177195192634, 5888.263967004124, 4145.834166633361, 4208.853484722814, 4235.428217190702, 4237.110206856594, 4248.532661407243, 4180.979095104505, 4225.64082053029, 4233.301505251599, 4253.404523366731, 4259.61663450291, 4772.253780782069, 4810.11012962603, 4816.771723210559, 4834.307992202771, 4835.646019114653, 5483.890322193533, 5699.287589051369, 5720.570957178228, 5739.827805165852, 5745.798897038583, 1440.3734375546671, 1458.7593047147313, 1461.3643065266642, 1465.6042868425466, 1467.9266036698123, 895.7414832160824, 931.4411353188033, 933.7292185266197, 940.7554035950566, 956.1155930764015, 4806.206975848946, 4816.470188279286, 4864.610831133501, 4890.559849613552, 4898.853034408973, 5156.535911767884, 5156.61325400589, 5188.610854185951, 5253.9019564739565, 5280.287161233261, 4652.395188625457, 4855.854324370274, 4857.635677324215, 4913.901721965541, 4930.921151214255, 2738.6302849115514, 2757.26932362924, 2768.9893188985875, 2777.6250206222307, 2779.555271156605, 5284.591438522131, 5292.285541451932, 5325.973370133124, 5342.572594192456, 5369.5972802040005, 4897.159647404497, 5153.793848246103, 5178.275041494194, 5257.684538927677, 5269.762860671279, 5181.740912954338, 5188.896222075613, 5209.765560549708, 5228.843134705965, 5296.841094767163, 5096.745162741922, 5126.769575301826, 5146.301720432323, 5178.591954741063, 5200.921986170135, 4781.713097214179, 5001.0, 5022.920072184352, 5027.597792176544, 5088.0587091388215, 5200.453952335101, 5225.869353266199, 5262.500062494057, 5310.867228319323, 5317.627766056339, 3793.098279815998, 3987.700922430887, 4023.2959232134845, 4081.387791831249, 4111.424400583861, 5797.942020579909, 5808.473314108376, 5809.651420914759, 5818.418158184148, 5822.7670893163795, 5523.392426832965, 5589.245451864109, 5631.774729010794, 5654.688992105309, 5708.200851880823, 5627.662340259434, 5627.8593035174445, 5628.1708444754795, 5638.21065050885, 5685.60200785941, 5638.379778224474, 5645.983722929748, 5648.181013753065, 5679.176519404746, 5715.542756579381, 5536.52939500147, 5651.943480565306, 5698.287714035746, 5724.656520608777, 5748.649067469058, 5552.167174923794, 5571.693556854412, 5587.497125258747, 5606.6916319602815, 5613.831585052455], "value": 4189.482413061972, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.6644844517183, 658.23973310826, 694.8228201808545, 730.6931088942644, 741.2994719989612, 13228.27244501552, 14027.158370497764, 14430.71138577229, 15514.689706205869, 15742.921285393586, 13663.863361366384, 13965.860341396608, 14180.787288190686, 14184.21986790726, 14190.929045354784, 785.0500893918365, 801.7113839017949, 810.7567729681101, 812.1391325195283, 813.5200231863199, 763.0995425398056, 814.6700586262543, 818.2104269380047, 822.48183644304, 822.6627082896014, 856.0326830681353, 856.4518708026836, 857.2499063319596, 860.0754189246554, 861.6897916749965, 850.2602735619988, 851.1063383447417, 851.3912552524944, 851.4763420496381, 854.465958775762, 623.5541587764725, 626.7493002798872, 628.3245511075612, 628.6008384675719, 629.7197747002585, 14707.63230919225, 15100.622484437867, 15154.545363639108, 15200.239988000556, 15223.238838058052, 12671.303078330688, 12762.0, 12949.676258093528, 13087.934560327138, 13429.194248345131, 10777.730556736144, 10962.958518940688, 11087.279326843729, 11144.164187685956, 11263.042641375492, 3678.558572971234, 3730.9067273318115, 3791.8672846450518, 3812.923741525182, 3899.0, 59271.703641481945, 60170.69914650399, 60596.69701651508, 60777.0, 62318.376816232165, 9791.167750741266, 10075.143612792848, 10079.395236285847, 10126.0, 10487.580496780196, 19211.135498902582, 19505.707414388795, 19653.41039768809, 19742.40772776819, 19757.506062348555, 7536.962315188389, 7778.416618753616, 7800.843983120306, 7891.802704932423, 7983.12185659577, 4260.25445547028, 4416.646668266595, 4443.0669559392245, 4479.865604031885, 4492.213862574036, 3273.4435146025235, 3380.915477113092, 3382.424987752088, 3394.728421726256, 3400.4559270517093, 564.3284491455155, 566.5552541255095, 573.7160105747681, 575.720775423919, 575.824373566058, 529.317180836724, 544.6024402186426, 547.9808206712746, 551.892380985712, 560.5991715923135, 8385.203405676451, 8528.701495447754, 8764.956175219084, 9079.273658107335, 9157.175854173156, 549.670197881268, 589.5107061139244, 618.2951435363689, 635.7774778827466, 660.4353277947382, 3771.4342848572933, 4049.53430355507, 4146.958530414718, 4241.34259189826, 4381.408509851193, 54597.45402546003, 56513.71743141258, 56517.43482565204, 70657.64671176611, 86252.56873715592, 71236.0, 74460.0, 78548.21451785523, 78854.605726971, 78863.21136788558, 67501.66249168722, 68525.0, 70169.64915175493, 70237.29762702409, 70845.64577177081, 9281.72154835356, 9491.572879220314, 9496.0, 9603.327767056518, 9640.0, 44864.32703509385, 45323.77338113288, 45921.0, 46471.53528464672, 46922.53077469182, 57626.7118664404, 59659.70170149121, 64695.0, 65221.0, 65353.67323163354, 11973.820392693942, 12048.0, 12204.511819527119, 12406.88886135547, 12540.686482838002, 13073.0, 13302.0, 13332.466701332227, 13524.526641567498, 13567.253801041037, 11539.4807233673, 11716.297022178696, 11777.175597708077, 12284.38578071075, 12820.679483013, 11341.149413793833, 11736.178467507192, 11762.470688818852, 11874.168808183344, 12241.326727030098, 11867.169298149047, 12019.699507512381, 12205.877941220475, 12223.388830558259, 12350.3824808761, 9487.478188699688, 9680.0, 10105.242106842163, 10287.279890407599, 10363.844542332023, 10455.94772026135, 10868.239223254297, 10944.069754070993, 10983.340999540053, 11037.392943388191], "value": 6806.384369401745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 114.0, 115.0, 113.0, 113.0, 114.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 124.0, 126.0, 173.0, 125.0, 132.0, 127.0, 125.0, 152.0, 126.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 172.0, 165.0, 176.0, 163.0, 163.0, 164.0, 163.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 76.0, 112.0, 79.0, 76.0, 76.0, 76.0, 98.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 113.0, 83.0, 82.0, 83.0, 100.0, 82.0, 84.0, 112.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 147.0, 147.0, 147.0, 146.0, 146.0, 148.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 86.0, 85.0, 85.0, 85.0, 85.0, 84.0, 88.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 56.0, 56.0, 57.0, 56.0, 60.0, 54.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 63.0, 63.0, 62.0, 61.0, 62.0, 65.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 80.0, 86.0, 80.0, 80.0, 79.0, 80.0, 80.0, 86.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 135.0, 142.0, 146.0, 136.0, 130.0, 141.0, 131.0, 168.0, 145.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 166.0, 166.0, 167.0, 166.0, 164.0, 168.0, 164.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 65.0, 65.0, 65.0, 65.0, 72.0, 71.0, 63.0, 63.0], "value": 65.7, "unit": "score"}]}]} 07:56:54 INFO - Return code: 0 07:56:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:56:54 ERROR - # TBPL SUCCESS # 07:56:54 INFO - Running post-action listener: _resource_record_post_action 07:56:54 INFO - [mozharness: 2016-10-30 14:56:54.403293Z] Finished run-tests step (success) 07:56:54 INFO - Running post-run listener: _resource_record_post_run 07:56:54 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 398671872; Read time: 16; Write time: 288892 07:56:54 INFO - TinderboxPrint: CPU usage
13.4% 07:56:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:56:54 INFO - TinderboxPrint: I/O write bytes / time
398,671,872 / 288,892 07:56:54 INFO - TinderboxPrint: CPU idle
8,247.3 (86.5%) 07:56:54 INFO - TinderboxPrint: CPU user
1,219.1 (12.8%) 07:56:54 INFO - TinderboxPrint: Swap in / out
0 / 0 07:56:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110309376; Read time: 0; Write time: 98428 07:56:54 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288362496; Read time: 0; Write time: 190464 07:56:55 INFO - Running post-run listener: _upload_blobber_files 07:56:55 INFO - Blob upload gear active. 07:56:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:56:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:56:55 INFO - (blobuploader) - INFO - Open directory for files ... 07:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:56 INFO - (blobuploader) - INFO - Done attempting. 07:56:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:56:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:56:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:56:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:56:59 INFO - (blobuploader) - INFO - Done attempting. 07:56:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:56:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:56:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:57:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:00 INFO - (blobuploader) - INFO - Done attempting. 07:57:00 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:00 INFO - Return code: 0 07:57:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b48a1c834a46c3c0ee4279150652739228b0e931b98adc4b9057dc6958d117ee0d049904e51c9de52dc5c53b86d3ed2695f6320afb64579c5d323fc42babd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3baabf17606d71ffedd78d2a476780da56ef1dd37b76cc91f4f3ed534e6da84f9708fcea413de3df51f55b2073946d2cf3e74a14790476f2a980719d9ab46a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df4b3e074674bc678b3fdcd8bf8360eac908fa14c486a35448504d5506365252e2a9b5e3a9da3c611ef3494b0e3ddf00343bba8c4b9e3ce178fd6bd3b7148864"} 07:57:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:00 INFO - Contents: 07:57:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b48a1c834a46c3c0ee4279150652739228b0e931b98adc4b9057dc6958d117ee0d049904e51c9de52dc5c53b86d3ed2695f6320afb64579c5d323fc42babd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3baabf17606d71ffedd78d2a476780da56ef1dd37b76cc91f4f3ed534e6da84f9708fcea413de3df51f55b2073946d2cf3e74a14790476f2a980719d9ab46a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df4b3e074674bc678b3fdcd8bf8360eac908fa14c486a35448504d5506365252e2a9b5e3a9da3c611ef3494b0e3ddf00343bba8c4b9e3ce178fd6bd3b7148864"} 07:57:00 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:00 INFO - Copying logs to upload dir... 07:57:00 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.223778 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-30 07:56:59.206690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:56:59.210820) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b48a1c834a46c3c0ee4279150652739228b0e931b98adc4b9057dc6958d117ee0d049904e51c9de52dc5c53b86d3ed2695f6320afb64579c5d323fc42babd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3baabf17606d71ffedd78d2a476780da56ef1dd37b76cc91f4f3ed534e6da84f9708fcea413de3df51f55b2073946d2cf3e74a14790476f2a980719d9ab46a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df4b3e074674bc678b3fdcd8bf8360eac908fa14c486a35448504d5506365252e2a9b5e3a9da3c611ef3494b0e3ddf00343bba8c4b9e3ce178fd6bd3b7148864"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477748280/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/33b48a1c834a46c3c0ee4279150652739228b0e931b98adc4b9057dc6958d117ee0d049904e51c9de52dc5c53b86d3ed2695f6320afb64579c5d323fc42babd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3baabf17606d71ffedd78d2a476780da56ef1dd37b76cc91f4f3ed534e6da84f9708fcea413de3df51f55b2073946d2cf3e74a14790476f2a980719d9ab46a58", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/df4b3e074674bc678b3fdcd8bf8360eac908fa14c486a35448504d5506365252e2a9b5e3a9da3c611ef3494b0e3ddf00343bba8c4b9e3ce178fd6bd3b7148864"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 07:56:59.236745) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:56:59.237109) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1477838182.426534-630407196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 07:56:59.319490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:56:59.319844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 07:56:59.320229) ========= ========= Total master_lag: 0.16 =========