builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1477287044.47 results: success (0) buildid: 20161023193001 builduid: 3509c31fc4c44e78bfecb791df3309a1 revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.465761) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.466218) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.466526) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.481554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.481886) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-23 22:30:45-- 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% 44.3M=0s 2016-10-23 22:30:45 (44.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.581228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.581596) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019315 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.640051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:44.640420) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-23 22:30:45,342 truncating revision to first 12 chars 2016-10-23 22:30:45,343 Setting DEBUG logging. 2016-10-23 22:30:45,343 attempt 1/10 2016-10-23 22:30:45,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/215f96861176?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 22:30:45,666 unpacking tar archive at: mozilla-central-215f96861176/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634374 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:45.287929) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:45.288196) ========= script_repo_revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:45.288595) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:45.288857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 22:30:45.298715) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-23 22:30:45.299025) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:30:46 INFO - MultiFileLogger online at 20161023 22:30:46 in /builds/slave/test 22:30:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:30:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:30:46 INFO - {'append_to_log': False, 22:30:46 INFO - 'base_work_dir': '/builds/slave/test', 22:30:46 INFO - 'blob_upload_branch': 'Firefox', 22:30:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:30:46 INFO - 'branch': 'Firefox', 22:30:46 INFO - 'buildbot_json_path': 'buildprops.json', 22:30:46 INFO - 'config_files': ('talos/linux_config.py',), 22:30:46 INFO - 'default_actions': ('clobber', 22:30:46 INFO - 'read-buildbot-config', 22:30:46 INFO - 'download-and-extract', 22:30:46 INFO - 'populate-webroot', 22:30:46 INFO - 'create-virtualenv', 22:30:46 INFO - 'install', 22:30:46 INFO - 'run-tests'), 22:30:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:30:46 INFO - 'download_minidump_stackwalk': True, 22:30:46 INFO - 'download_symbols': 'ondemand', 22:30:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:30:46 INFO - 'tooltool.py': '/tools/tooltool.py', 22:30:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:30:46 INFO - '/tools/misc-python/virtualenv.py')}, 22:30:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:30:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:30:46 INFO - 'installer_path': 'installer.exe', 22:30:46 INFO - 'log_level': 'info', 22:30:46 INFO - 'log_name': 'talos', 22:30:46 INFO - 'log_to_console': True, 22:30:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:30:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:30:46 INFO - 'opt_config_files': (), 22:30:46 INFO - 'pip_index': False, 22:30:46 INFO - 'sps_profile': False, 22:30:46 INFO - 'sps_profile_interval': 0, 22:30:46 INFO - 'suite': 'dromaeojs-e10s', 22:30:46 INFO - 'system_bits': '32', 22:30:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:30:46 INFO - 'title': 'talos-linux64-ix-002', 22:30:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:30:46 INFO - 'use_talos_json': True, 22:30:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:30:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:30:46 INFO - 'work_dir': 'build'} 22:30:46 INFO - [mozharness: 2016-10-24 05:30:46.102824Z] Running clobber step. 22:30:46 INFO - Running pre-action listener: _resource_record_pre_action 22:30:46 INFO - Running main action method: clobber 22:30:46 INFO - rmtree: /builds/slave/test/build 22:30:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:30:46 INFO - Running post-action listener: _resource_record_post_action 22:30:46 INFO - [mozharness: 2016-10-24 05:30:46.565291Z] Finished clobber step (success) 22:30:46 INFO - [mozharness: 2016-10-24 05:30:46.565391Z] Running read-buildbot-config step. 22:30:46 INFO - Running pre-action listener: _resource_record_pre_action 22:30:46 INFO - Running main action method: read_buildbot_config 22:30:46 INFO - Using buildbot properties: 22:30:46 INFO - { 22:30:46 INFO - "project": "", 22:30:46 INFO - "product": "firefox", 22:30:46 INFO - "script_repo_revision": "production", 22:30:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:30:46 INFO - "repository": "", 22:30:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:30:46 INFO - "buildid": "20161023193001", 22:30:46 INFO - "pgo_build": "True", 22:30:46 INFO - "basedir": "/builds/slave/test", 22:30:46 INFO - "buildnumber": 129, 22:30:46 INFO - "slavename": "talos-linux64-ix-002", 22:30:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:30:46 INFO - "platform": "ubuntu64_hw", 22:30:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:30:46 INFO - "branch": "mozilla-central", 22:30:46 INFO - "repo_path": "mozilla-central", 22:30:46 INFO - "revision": "215f9686117673a2c914ed207bc7da9bb8d741ad", 22:30:46 INFO - "stage_platform": "linux64-pgo", 22:30:46 INFO - "builduid": "3509c31fc4c44e78bfecb791df3309a1", 22:30:46 INFO - "slavebuilddir": "test" 22:30:46 INFO - } 22:30:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 22:30:46 INFO - Running post-action listener: _resource_record_post_action 22:30:46 INFO - [mozharness: 2016-10-24 05:30:46.567824Z] Finished read-buildbot-config step (success) 22:30:46 INFO - [mozharness: 2016-10-24 05:30:46.567913Z] Running download-and-extract step. 22:30:46 INFO - Running pre-action listener: _resource_record_pre_action 22:30:46 INFO - Running main action method: download_and_extract 22:30:46 INFO - mkdir: /builds/slave/test/build/tests 22:30:46 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')]} 22:30:46 INFO - trying https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:30:46 INFO - Downloading https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/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 22:30:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/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 22:30:47 INFO - Downloaded 1361 bytes. 22:30:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 22:30:47 INFO - Using the following test package requirements: 22:30:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:30:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:30:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'jsshell-linux-x86_64.zip'], 22:30:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:30:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 22:30:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:30:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:30:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:30:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 22:30:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:30:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:30:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:30:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:30:47 INFO - Http code: 200 22:30:47 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 22:30:47 INFO - x-amz-cf-id: q8Jjh_b-Wv8x3lnxE4u0Ii4fVTgW0Xn16PRKfq5ouji0RMcqWL1DbA== 22:30:47 INFO - x-amz-version-id: y.DDuLscrR14yyvhPJY7Zo_q6lIAQ8AO 22:30:48 INFO - Expected file size: 22022064 22:30:48 INFO - Obtained file size: 22022064 22:30:52 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 22:30:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 22:30:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:30:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 22:30:53 INFO - Http code: 200 22:30:53 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 22:30:53 INFO - x-amz-cf-id: rPsEItVRNOxobjY0FHr6r4BLQ-wJdfGwRfUqXpkJvCCbMreKhqVYBg== 22:30:53 INFO - x-amz-version-id: y.DDuLscrR14yyvhPJY7Zo_q6lIAQ8AO 22:30:53 INFO - Expected file size: 22022064 22:30:53 INFO - Obtained file size: 22022064 22:30:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 22:30:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:30:58 INFO - Fetch https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 22:30:58 INFO - Http code: 200 22:30:58 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 22:30:58 INFO - x-amz-cf-id: vz3NGN3FNAH8LYb9IbcfuhCcnyV2HB_1vuHhEYQLoc0Q5yCLz9XvDw== 22:30:58 INFO - x-amz-version-id: m0I9ldyZ4t8CtiEmo.w37mczHnFUlGMj 22:31:00 INFO - Expected file size: 14409028 22:31:00 INFO - Obtained file size: 14409028 22:31:00 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')]} 22:31:00 INFO - trying https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:00 INFO - Downloading https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/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 22:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/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 22:31:02 INFO - Downloaded 59367226 bytes. 22:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:02 INFO - mkdir: /builds/slave/test/properties 22:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:31:02 INFO - Contents: 22:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 22:31:03 INFO - Running post-action listener: _resource_record_post_action 22:31:03 INFO - Running post-action listener: set_extra_try_arguments 22:31:03 INFO - [mozharness: 2016-10-24 05:31:03.418224Z] Finished download-and-extract step (success) 22:31:03 INFO - [mozharness: 2016-10-24 05:31:03.418452Z] Running populate-webroot step. 22:31:03 INFO - Running pre-action listener: _resource_record_pre_action 22:31:03 INFO - Running main action method: populate_webroot 22:31:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:31:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:31:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:31:03 INFO - '--tppagecycles', 22:31:03 INFO - '7'], 22:31:03 INFO - 'tests': ['tsvgm']}}, 22:31:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:31:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:31:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:31:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:31:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:31:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['damp', 'tps']}, 22:31:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'tests': ['damp', 'tps']}, 22:31:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['dromaeo_dom']}, 22:31:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:31:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['basic_compositor_video']}, 22:31:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:31:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'other-e10s': {'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['a11yr', 22:31:03 INFO - 'ts_paint', 22:31:03 INFO - 'tpaint', 22:31:03 INFO - 'sessionrestore', 22:31:03 INFO - 'sessionrestore_no_auto_restore', 22:31:03 INFO - 'tabpaint']}, 22:31:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['tsvgx', 22:31:03 INFO - 'tsvgr_opacity', 22:31:03 INFO - 'tart', 22:31:03 INFO - 'tscrollx', 22:31:03 INFO - 'cart']}, 22:31:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:31:03 INFO - 'tsvgr_opacity', 22:31:03 INFO - 'tart', 22:31:03 INFO - 'tscrollx', 22:31:03 INFO - 'cart']}, 22:31:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'talos_options': ['--disable-e10s'], 22:31:03 INFO - 'tests': ['tp5o']}, 22:31:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'tests': ['tp5o']}, 22:31:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'talos_options': ['--disable-e10s', 22:31:03 INFO - '--xperf_path', 22:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:03 INFO - 'tests': ['tp5n']}, 22:31:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:31:03 INFO - 'talos_options': ['--xperf_path', 22:31:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:31:03 INFO - 'tests': ['tp5n']}}, 22:31:03 INFO - 'talos.zip': {'path': '', 22:31:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:31:03 INFO - Running post-action listener: _resource_record_post_action 22:31:03 INFO - [mozharness: 2016-10-24 05:31:03.437591Z] Finished populate-webroot step (success) 22:31:03 INFO - [mozharness: 2016-10-24 05:31:03.437679Z] Running create-virtualenv step. 22:31:03 INFO - Running pre-action listener: _resource_record_pre_action 22:31:03 INFO - Running main action method: create_virtualenv 22:31:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:31:03 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 22:31:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:31:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:31:03 INFO - Using real prefix '/usr' 22:31:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:31:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:31:06 INFO - Installing pip.................done. 22:31:06 INFO - Return code: 0 22:31:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:31:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:31:06 INFO - Reading from file tmpfile_stdout 22:31:06 INFO - Output received: 22:31:06 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) 22:31:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:31:06 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')]} 22:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 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')]} 22:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:06 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 22:31:06 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 22:31:06 INFO - Using env: {'DISPLAY': ':0', 22:31:06 INFO - 'HOME': '/home/cltbld', 22:31:06 INFO - 'LANG': 'en_US.UTF-8', 22:31:06 INFO - 'LANGUAGE': 'en_US:en', 22:31:06 INFO - 'LOGNAME': 'cltbld', 22:31:06 INFO - 'MAIL': '/var/mail/cltbld', 22:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:06 INFO - 'MOZ_NO_REMOTE': '1', 22:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:06 INFO - 'NO_EM_RESTART': '1', 22:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:06 INFO - 'PWD': '/builds/slave/test', 22:31:06 INFO - 'SHELL': '/bin/bash', 22:31:06 INFO - 'SHLVL': '1', 22:31:06 INFO - 'TERM': 'linux', 22:31:06 INFO - 'TMOUT': '86400', 22:31:06 INFO - 'USER': 'cltbld', 22:31:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:06 INFO - '_': '/tools/buildbot/bin/python'} 22:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:06 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 22:31:06 INFO - Cleaning up... 22:31:06 INFO - Return code: 0 22:31:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:31:06 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')]} 22:31:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 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')]} 22:31:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:06 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:06 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 22:31:06 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 22:31:06 INFO - Using env: {'DISPLAY': ':0', 22:31:06 INFO - 'HOME': '/home/cltbld', 22:31:06 INFO - 'LANG': 'en_US.UTF-8', 22:31:06 INFO - 'LANGUAGE': 'en_US:en', 22:31:06 INFO - 'LOGNAME': 'cltbld', 22:31:06 INFO - 'MAIL': '/var/mail/cltbld', 22:31:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:06 INFO - 'MOZ_NO_REMOTE': '1', 22:31:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:06 INFO - 'NO_EM_RESTART': '1', 22:31:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:06 INFO - 'PWD': '/builds/slave/test', 22:31:06 INFO - 'SHELL': '/bin/bash', 22:31:06 INFO - 'SHLVL': '1', 22:31:06 INFO - 'TERM': 'linux', 22:31:06 INFO - 'TMOUT': '86400', 22:31:06 INFO - 'USER': 'cltbld', 22:31:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:06 INFO - '_': '/tools/buildbot/bin/python'} 22:31:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:06 INFO - Downloading/unpacking psutil>=3.1.1 22:31:06 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 22:31:06 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 22:31:06 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 22:31:06 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 22:31:06 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 22:31:06 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 22:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:31:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:08 INFO - Installing collected packages: psutil 22:31:08 INFO - Running setup.py install for psutil 22:31:08 INFO - building 'psutil._psutil_linux' extension 22:31:08 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 22:31:08 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 22:31:08 INFO - building 'psutil._psutil_posix' extension 22:31:08 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 22:31:09 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 22:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:31:09 INFO - Successfully installed psutil 22:31:09 INFO - Cleaning up... 22:31:09 INFO - Return code: 0 22:31:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:31:09 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')]} 22:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:09 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')]} 22:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:09 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:09 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 22:31:09 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 22:31:09 INFO - Using env: {'DISPLAY': ':0', 22:31:09 INFO - 'HOME': '/home/cltbld', 22:31:09 INFO - 'LANG': 'en_US.UTF-8', 22:31:09 INFO - 'LANGUAGE': 'en_US:en', 22:31:09 INFO - 'LOGNAME': 'cltbld', 22:31:09 INFO - 'MAIL': '/var/mail/cltbld', 22:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:09 INFO - 'MOZ_NO_REMOTE': '1', 22:31:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:09 INFO - 'NO_EM_RESTART': '1', 22:31:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:09 INFO - 'PWD': '/builds/slave/test', 22:31:09 INFO - 'SHELL': '/bin/bash', 22:31:09 INFO - 'SHLVL': '1', 22:31:09 INFO - 'TERM': 'linux', 22:31:09 INFO - 'TMOUT': '86400', 22:31:09 INFO - 'USER': 'cltbld', 22:31:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:09 INFO - '_': '/tools/buildbot/bin/python'} 22:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:31:09 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 22:31:09 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 22:31:09 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 22:31:09 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 22:31:09 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 22:31:09 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 22:31:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:31:11 INFO - Installing collected packages: mozsystemmonitor 22:31:11 INFO - Running setup.py install for mozsystemmonitor 22:31:11 INFO - Successfully installed mozsystemmonitor 22:31:11 INFO - Cleaning up... 22:31:11 INFO - Return code: 0 22:31:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:31:11 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')]} 22:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:11 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')]} 22:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:11 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:11 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 22:31:11 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 22:31:11 INFO - Using env: {'DISPLAY': ':0', 22:31:11 INFO - 'HOME': '/home/cltbld', 22:31:11 INFO - 'LANG': 'en_US.UTF-8', 22:31:11 INFO - 'LANGUAGE': 'en_US:en', 22:31:11 INFO - 'LOGNAME': 'cltbld', 22:31:11 INFO - 'MAIL': '/var/mail/cltbld', 22:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:11 INFO - 'MOZ_NO_REMOTE': '1', 22:31:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:11 INFO - 'NO_EM_RESTART': '1', 22:31:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:11 INFO - 'PWD': '/builds/slave/test', 22:31:11 INFO - 'SHELL': '/bin/bash', 22:31:11 INFO - 'SHLVL': '1', 22:31:11 INFO - 'TERM': 'linux', 22:31:11 INFO - 'TMOUT': '86400', 22:31:11 INFO - 'USER': 'cltbld', 22:31:11 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:11 INFO - '_': '/tools/buildbot/bin/python'} 22:31:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:11 INFO - Downloading/unpacking jsonschema==2.5.1 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:11 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 22:31:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:31:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:31:13 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 22:31:13 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 22:31:13 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 22:31:13 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 22:31:13 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 22:31:13 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 22:31:13 INFO - Downloading functools32-3.2.3-2.tar.gz 22:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:31:13 INFO - warning: no files found matching '*.txt' 22:31:13 INFO - no previously-included directories found matching 'build' 22:31:13 INFO - no previously-included directories found matching 'dist' 22:31:13 INFO - no previously-included directories found matching '.git*' 22:31:13 INFO - Installing collected packages: jsonschema, functools32 22:31:14 INFO - Running setup.py install for functools32 22:31:14 INFO - warning: no files found matching '*.txt' 22:31:14 INFO - no previously-included directories found matching 'build' 22:31:14 INFO - no previously-included directories found matching 'dist' 22:31:14 INFO - no previously-included directories found matching '.git*' 22:31:14 INFO - Successfully installed jsonschema functools32 22:31:14 INFO - Cleaning up... 22:31:14 INFO - Return code: 0 22:31:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:31:14 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')]} 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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')]} 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:14 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 22:31:14 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 22:31:14 INFO - Using env: {'DISPLAY': ':0', 22:31:14 INFO - 'HOME': '/home/cltbld', 22:31:14 INFO - 'LANG': 'en_US.UTF-8', 22:31:14 INFO - 'LANGUAGE': 'en_US:en', 22:31:14 INFO - 'LOGNAME': 'cltbld', 22:31:14 INFO - 'MAIL': '/var/mail/cltbld', 22:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:14 INFO - 'MOZ_NO_REMOTE': '1', 22:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:14 INFO - 'NO_EM_RESTART': '1', 22:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:14 INFO - 'PWD': '/builds/slave/test', 22:31:14 INFO - 'SHELL': '/bin/bash', 22:31:14 INFO - 'SHLVL': '1', 22:31:14 INFO - 'TERM': 'linux', 22:31:14 INFO - 'TMOUT': '86400', 22:31:14 INFO - 'USER': 'cltbld', 22:31:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:14 INFO - '_': '/tools/buildbot/bin/python'} 22:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:31:14 INFO - Cleaning up... 22:31:14 INFO - Return code: 0 22:31:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:31:14 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')]} 22:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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')]} 22:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:14 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:14 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 22:31:14 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 22:31:14 INFO - Using env: {'DISPLAY': ':0', 22:31:14 INFO - 'HOME': '/home/cltbld', 22:31:14 INFO - 'LANG': 'en_US.UTF-8', 22:31:14 INFO - 'LANGUAGE': 'en_US:en', 22:31:14 INFO - 'LOGNAME': 'cltbld', 22:31:14 INFO - 'MAIL': '/var/mail/cltbld', 22:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:14 INFO - 'MOZ_NO_REMOTE': '1', 22:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:14 INFO - 'NO_EM_RESTART': '1', 22:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:14 INFO - 'PWD': '/builds/slave/test', 22:31:14 INFO - 'SHELL': '/bin/bash', 22:31:14 INFO - 'SHLVL': '1', 22:31:14 INFO - 'TERM': 'linux', 22:31:14 INFO - 'TMOUT': '86400', 22:31:14 INFO - 'USER': 'cltbld', 22:31:14 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:14 INFO - '_': '/tools/buildbot/bin/python'} 22:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:14 INFO - Downloading/unpacking blobuploader==1.2.4 22:31:14 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 22:31:14 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 22:31:14 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 22:31:14 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 22:31:14 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 22:31:14 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 22:31:16 INFO - Downloading blobuploader-1.2.4.tar.gz 22:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:31:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 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 22:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:31:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:31:17 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 22:31:17 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 22:31:17 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 22:31:17 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 22:31:17 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 22:31:17 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 22:31:17 INFO - Downloading docopt-0.6.1.tar.gz 22:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:31:17 INFO - Installing collected packages: blobuploader, requests, docopt 22:31:17 INFO - Running setup.py install for blobuploader 22:31:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:31:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:31:17 INFO - Running setup.py install for requests 22:31:17 INFO - Running setup.py install for docopt 22:31:17 INFO - Successfully installed blobuploader requests docopt 22:31:17 INFO - Cleaning up... 22:31:17 INFO - Return code: 0 22:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:17 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')]} 22:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:17 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')]} 22:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:17 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:17 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 22:31:17 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 22:31:17 INFO - Using env: {'DISPLAY': ':0', 22:31:17 INFO - 'HOME': '/home/cltbld', 22:31:17 INFO - 'LANG': 'en_US.UTF-8', 22:31:17 INFO - 'LANGUAGE': 'en_US:en', 22:31:17 INFO - 'LOGNAME': 'cltbld', 22:31:17 INFO - 'MAIL': '/var/mail/cltbld', 22:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:17 INFO - 'MOZ_NO_REMOTE': '1', 22:31:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:17 INFO - 'NO_EM_RESTART': '1', 22:31:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:17 INFO - 'PWD': '/builds/slave/test', 22:31:17 INFO - 'SHELL': '/bin/bash', 22:31:17 INFO - 'SHLVL': '1', 22:31:17 INFO - 'TERM': 'linux', 22:31:17 INFO - 'TMOUT': '86400', 22:31:17 INFO - 'USER': 'cltbld', 22:31:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:17 INFO - '_': '/tools/buildbot/bin/python'} 22:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:18 INFO - Running setup.py (path:/tmp/pip-7gtIOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:18 INFO - Running setup.py (path:/tmp/pip-ejOQsw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:18 INFO - Running setup.py (path:/tmp/pip-5BHUzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:18 INFO - Running setup.py (path:/tmp/pip-fh5Aun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:18 INFO - Running setup.py (path:/tmp/pip-TvlEo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:18 INFO - Running setup.py (path:/tmp/pip-GyWZ0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:18 INFO - Running setup.py (path:/tmp/pip-Wx6Kcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:18 INFO - Running setup.py (path:/tmp/pip-_1HVQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:18 INFO - Running setup.py (path:/tmp/pip-YVnmFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:18 INFO - Running setup.py (path:/tmp/pip-ypCpdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:18 INFO - Running setup.py (path:/tmp/pip-APCS54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:18 INFO - Running setup.py (path:/tmp/pip-pkOD4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:19 INFO - Running setup.py (path:/tmp/pip-fr04yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:19 INFO - Running setup.py (path:/tmp/pip-ZEJXt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:19 INFO - Running setup.py (path:/tmp/pip-lnrnA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:19 INFO - Running setup.py (path:/tmp/pip-VQUkCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:19 INFO - Running setup.py (path:/tmp/pip-6pAhEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:31:19 INFO - Running setup.py install for manifestparser 22:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:31:19 INFO - Running setup.py install for mozcrash 22:31:19 INFO - Running setup.py install for mozdebug 22:31:19 INFO - Running setup.py install for mozdevice 22:31:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:31:19 INFO - Running setup.py install for mozfile 22:31:19 INFO - Running setup.py install for mozhttpd 22:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:31:19 INFO - Running setup.py install for mozinfo 22:31:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for mozInstall 22:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for mozleak 22:31:20 INFO - Running setup.py install for mozlog 22:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for moznetwork 22:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for mozprocess 22:31:20 INFO - Running setup.py install for mozprofile 22:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for mozrunner 22:31:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:31:20 INFO - Running setup.py install for mozscreenshot 22:31:20 INFO - Running setup.py install for moztest 22:31:21 INFO - Running setup.py install for mozversion 22:31:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:31:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:31:21 INFO - Cleaning up... 22:31:21 INFO - Return code: 0 22:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31:21 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')]} 22:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:21 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')]} 22:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:21 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:21 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 22:31:21 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 22:31:21 INFO - Using env: {'DISPLAY': ':0', 22:31:21 INFO - 'HOME': '/home/cltbld', 22:31:21 INFO - 'LANG': 'en_US.UTF-8', 22:31:21 INFO - 'LANGUAGE': 'en_US:en', 22:31:21 INFO - 'LOGNAME': 'cltbld', 22:31:21 INFO - 'MAIL': '/var/mail/cltbld', 22:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:21 INFO - 'MOZ_NO_REMOTE': '1', 22:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:21 INFO - 'NO_EM_RESTART': '1', 22:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:21 INFO - 'PWD': '/builds/slave/test', 22:31:21 INFO - 'SHELL': '/bin/bash', 22:31:21 INFO - 'SHLVL': '1', 22:31:21 INFO - 'TERM': 'linux', 22:31:21 INFO - 'TMOUT': '86400', 22:31:21 INFO - 'USER': 'cltbld', 22:31:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:21 INFO - '_': '/tools/buildbot/bin/python'} 22:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:31:21 INFO - Running setup.py (path:/tmp/pip-wjgGg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:31:21 INFO - Running setup.py (path:/tmp/pip-D3jE1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:31:21 INFO - Running setup.py (path:/tmp/pip-FMs6CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:31:21 INFO - Running setup.py (path:/tmp/pip-jloiZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:31:21 INFO - Running setup.py (path:/tmp/pip-2ZpRZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:31:21 INFO - Running setup.py (path:/tmp/pip-W6cfI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:31:21 INFO - Running setup.py (path:/tmp/pip-VP21qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:31:21 INFO - Running setup.py (path:/tmp/pip-RJpRSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:31:21 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)) 22:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:31:21 INFO - Running setup.py (path:/tmp/pip-L10gSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:31:22 INFO - Running setup.py (path:/tmp/pip-ctb8kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:31:22 INFO - Running setup.py (path:/tmp/pip-CDgv3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:31:22 INFO - Running setup.py (path:/tmp/pip-Jp2A6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:31:22 INFO - Running setup.py (path:/tmp/pip-DO0Eix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:31:22 INFO - Running setup.py (path:/tmp/pip-W5oqk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:22 INFO - Running setup.py (path:/tmp/pip-vKlJCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:31:22 INFO - Running setup.py (path:/tmp/pip-PwwduQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:31:22 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)) 22:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:31:22 INFO - Running setup.py (path:/tmp/pip-PHNCMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:31:22 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)) 22:31:22 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)) 22:31:22 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)) 22:31:22 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)) 22:31:22 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)) 22:31:22 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)) 22:31:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:22 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 22:31:24 INFO - Downloading blessings-1.6.tar.gz 22:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:31:24 INFO - Installing collected packages: blessings 22:31:24 INFO - Running setup.py install for blessings 22:31:24 INFO - Successfully installed blessings 22:31:24 INFO - Cleaning up... 22:31:24 INFO - Return code: 0 22:31:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:25 INFO - Reading from file tmpfile_stdout 22:31:25 INFO - Current package versions: 22:31:25 INFO - argparse == 1.2.1 22:31:25 INFO - blessings == 1.6 22:31:25 INFO - blobuploader == 1.2.4 22:31:25 INFO - docopt == 0.6.1 22:31:25 INFO - functools32 == 3.2.3-2 22:31:25 INFO - jsonschema == 2.5.1 22:31:25 INFO - manifestparser == 1.1 22:31:25 INFO - mozInstall == 1.12 22:31:25 INFO - mozcrash == 0.17 22:31:25 INFO - mozdebug == 0.1 22:31:25 INFO - mozdevice == 0.48 22:31:25 INFO - mozfile == 1.2 22:31:25 INFO - mozhttpd == 0.7 22:31:25 INFO - mozinfo == 0.9 22:31:25 INFO - mozleak == 0.1 22:31:25 INFO - mozlog == 3.4 22:31:25 INFO - moznetwork == 0.27 22:31:25 INFO - mozprocess == 0.23 22:31:25 INFO - mozprofile == 0.28 22:31:25 INFO - mozrunner == 6.12 22:31:25 INFO - mozscreenshot == 0.1 22:31:25 INFO - mozsystemmonitor == 0.3 22:31:25 INFO - moztest == 0.7 22:31:25 INFO - mozversion == 1.4 22:31:25 INFO - psutil == 3.1.1 22:31:25 INFO - requests == 1.2.3 22:31:25 INFO - wsgiref == 0.1.2 22:31:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:25 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:25 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 22:31:25 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 22:31:25 INFO - Using env: {'DISPLAY': ':0', 22:31:25 INFO - 'HOME': '/home/cltbld', 22:31:25 INFO - 'LANG': 'en_US.UTF-8', 22:31:25 INFO - 'LANGUAGE': 'en_US:en', 22:31:25 INFO - 'LOGNAME': 'cltbld', 22:31:25 INFO - 'MAIL': '/var/mail/cltbld', 22:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:25 INFO - 'MOZ_NO_REMOTE': '1', 22:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:25 INFO - 'NO_EM_RESTART': '1', 22:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:25 INFO - 'PWD': '/builds/slave/test', 22:31:25 INFO - 'SHELL': '/bin/bash', 22:31:25 INFO - 'SHLVL': '1', 22:31:25 INFO - 'TERM': 'linux', 22:31:25 INFO - 'TMOUT': '86400', 22:31:25 INFO - 'USER': 'cltbld', 22:31:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:25 INFO - '_': '/tools/buildbot/bin/python'} 22:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 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)) 22:31:25 INFO - Cleaning up... 22:31:25 INFO - Return code: 0 22:31:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:31: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')]} 22:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:31:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31: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')]} 22:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:31:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:31:25 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 0x7fe53da9df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2320790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', '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 22:31:25 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 22:31:25 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 22:31:25 INFO - Using env: {'DISPLAY': ':0', 22:31:25 INFO - 'HOME': '/home/cltbld', 22:31:25 INFO - 'LANG': 'en_US.UTF-8', 22:31:25 INFO - 'LANGUAGE': 'en_US:en', 22:31:25 INFO - 'LOGNAME': 'cltbld', 22:31:25 INFO - 'MAIL': '/var/mail/cltbld', 22:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:25 INFO - 'MOZ_NO_REMOTE': '1', 22:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:25 INFO - 'NO_EM_RESTART': '1', 22:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:25 INFO - 'PWD': '/builds/slave/test', 22:31:25 INFO - 'SHELL': '/bin/bash', 22:31:25 INFO - 'SHLVL': '1', 22:31:25 INFO - 'TERM': 'linux', 22:31:25 INFO - 'TMOUT': '86400', 22:31:25 INFO - 'USER': 'cltbld', 22:31:25 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:25 INFO - '_': '/tools/buildbot/bin/python'} 22:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:31:25 INFO - Cleaning up... 22:31:25 INFO - Return code: 0 22:31:25 INFO - Running post-action listener: _resource_record_post_action 22:31:25 INFO - Running post-action listener: _start_resource_monitoring 22:31:25 INFO - Starting resource monitoring. 22:31:25 INFO - [mozharness: 2016-10-24 05:31:25.524265Z] Finished create-virtualenv step (success) 22:31:25 INFO - [mozharness: 2016-10-24 05:31:25.524791Z] Running install step. 22:31:25 INFO - Running pre-action listener: _resource_record_pre_action 22:31:25 INFO - Running main action method: install 22:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:31:25 INFO - Reading from file tmpfile_stdout 22:31:25 INFO - Detecting whether we're running mozinstall >=1.0... 22:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:31:25 INFO - Reading from file tmpfile_stdout 22:31:25 INFO - Output received: 22:31:25 INFO - Usage: mozinstall [options] installer 22:31:25 INFO - Options: 22:31:25 INFO - -h, --help show this help message and exit 22:31:25 INFO - -d DEST, --destination=DEST 22:31:25 INFO - Directory to install application into. [default: 22:31:25 INFO - "/builds/slave/test"] 22:31:25 INFO - --app=APP Application being installed. [default: firefox] 22:31:25 INFO - mkdir: /builds/slave/test/build/application 22:31:25 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'] 22:31:25 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 22:31:42 INFO - Reading from file tmpfile_stdout 22:31:42 INFO - Output received: 22:31:42 INFO - /builds/slave/test/build/application/firefox/firefox 22:31:42 INFO - Running post-action listener: _resource_record_post_action 22:31:42 INFO - [mozharness: 2016-10-24 05:31:42.721961Z] Finished install step (success) 22:31:42 INFO - [mozharness: 2016-10-24 05:31:42.722209Z] Running run-tests step. 22:31:42 INFO - Running pre-action listener: _resource_record_pre_action 22:31:42 INFO - Running main action method: run_tests 22:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:31:42 INFO - Python 2.7.3 22:31:42 INFO - Return code: 0 22:31:42 INFO - grabbing minidump binary from tooltool 22:31: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')]} 22:31:42 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 0x231d930>, '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 0x231e830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231ecc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:31:42 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 22:31:42 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 22:31:42 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 22:31:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:31:42 INFO - Return code: 0 22:31:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:31:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:31:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:31:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:31:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 22:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 22:31:42 INFO - Using env: {'DISPLAY': ':0', 22:31:42 INFO - 'HOME': '/home/cltbld', 22:31:42 INFO - 'LANG': 'en_US.UTF-8', 22:31:42 INFO - 'LANGUAGE': 'en_US:en', 22:31:42 INFO - 'LOGNAME': 'cltbld', 22:31:42 INFO - 'MAIL': '/var/mail/cltbld', 22:31:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:31:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:31:42 INFO - 'MOZ_NO_REMOTE': '1', 22:31:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:31:42 INFO - 'NO_EM_RESTART': '1', 22:31:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:31:42 INFO - 'PWD': '/builds/slave/test', 22:31:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:31:42 INFO - 'SHELL': '/bin/bash', 22:31:42 INFO - 'SHLVL': '1', 22:31:42 INFO - 'TERM': 'linux', 22:31:42 INFO - 'TMOUT': '86400', 22:31:42 INFO - 'USER': 'cltbld', 22:31:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275', 22:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:31:42 INFO - '_': '/tools/buildbot/bin/python'} 22:31:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 22:31:42 INFO - mozversion application_buildid: 20161023193001 22:31:43 INFO - mozversion application_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 22:31:43 INFO - mozversion application_display_name: Nightly 22:31:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:31:43 INFO - mozversion application_name: Firefox 22:31:43 INFO - mozversion application_remotingname: firefox 22:31:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:31:43 INFO - mozversion application_vendor: Mozilla 22:31:43 INFO - mozversion application_version: 52.0a1 22:31:43 INFO - mozversion platform_buildid: 20161023193001 22:31:43 INFO - mozversion platform_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 22:31:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:31:43 INFO - mozversion platform_version: 52.0a1 22:31:43 INFO - using testdate: 1477287103 22:31:43 INFO - actual date: 1477287103 22:31:43 INFO - starting webserver on 'localhost:51793' 22:31:43 INFO - SUITE-START | Running 2 tests 22:31:43 INFO - TEST-START | dromaeo_css 22:31:43 INFO - operating with platform_type : linux_ 22:31:43 INFO - Initialising browser for dromaeo_css test... 22:31:43 INFO - TEST-INFO | started process 32330 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9IymfX/profile http://localhost:51793/getInfo.html) 22:31:47 INFO - PROCESS | 32330 | __metrics Screen width/height:1600/1200 22:31:47 INFO - PROCESS | 32330 | colorDepth:24 22:31:47 INFO - PROCESS | 32330 | Browser inner width/height: 1024/697 22:31:47 INFO - PROCESS | 32330 | __metrics 22:31:47 ERROR - PROCESS | 32330 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 22:31:48 INFO - TEST-INFO | 32330: exit 0 22:31:48 INFO - Browser initialized. 22:31:48 INFO - Running cycle 1/1 for dromaeo_css test... 22:31:48 INFO - TEST-INFO | started process 32455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9IymfX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:32:01 INFO - PROCESS | 32455 | RSS: Main: 182796288 22:32:01 INFO - PROCESS | 32455 | 22:32:50 INFO - PROCESS | 32455 | 1477287170753 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] 22:35:02 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51793/tests/dromaeo/cssquery-ext.html) 22:35:03 INFO - PROCESS | 32455 | RSS: Main: 196255744 22:35:03 INFO - PROCESS | 32455 | 22:38:06 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-ext.html (next: http://localhost:51793/tests/dromaeo/cssquery-jquery.html) 22:38:06 INFO - PROCESS | 32455 | RSS: Main: 194899968 22:38:06 INFO - PROCESS | 32455 | 22:41:08 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51793/tests/dromaeo/cssquery-mootools.html) 22:41:09 INFO - PROCESS | 32455 | RSS: Main: 197062656 22:41:09 INFO - PROCESS | 32455 | 22:44:11 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51793/tests/dromaeo/cssquery-prototype.html) 22:44:12 INFO - PROCESS | 32455 | RSS: Main: 193601536 22:44:12 INFO - PROCESS | 32455 | 22:47:14 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51793/tests/dromaeo/cssquery-yui.html) 22:47:15 INFO - PROCESS | 32455 | RSS: Main: 197009408 22:47:15 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | Cycle 1(1): loaded http://localhost:51793/tests/dromaeo/cssquery-yui.html (next: http://localhost:51793/tests/dromaeo/cssquery-dojo.html) 22:50:18 INFO - PROCESS | 32455 | RSS: Main: 196591616 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | __start_tp_report 22:50:18 INFO - PROCESS | 32455 | _x_x_mozilla_page_load 22:50:18 INFO - PROCESS | 32455 | _x_x_mozilla_page_load_details 22:50:18 INFO - PROCESS | 32455 | |i|pagename|runs| 22:50:18 INFO - PROCESS | 32455 | |0;dojo.html;3153.5585018097463;3170.048985304411;3190.234343757499;3198.3923054619604;3200.879692107762;5322.228276899857;5489.478499542542;5503.367112782032;5532.059549876521;5569.777208911649;5374.811881584145;5479.945200547993;5493.533049690771;5536.280283563131;5601.075822489294;4998.150314446535;5021.297018417425;5083.872903177413;5117.974410127963;5154.6134039946965;5047.31861198739;5135.383753949532;5153.660048387427;5156.381234251895;5218.712970786605;4950.752462376903;4952.380952380952;5049.747512624354;5066.290719299301;5131.153359695664;5008.073506401327;5012.298278241049;5016.04695107932;5020.523050310251;5025.271335656309;4936.728479933602;4956.058348913695;5011.548960593527;5017.448080711155;5047.772850221749;5447.264619276387;5471.316085489314;5513.917291240595;5514.972425137888;5528.253685752412;5892.116182572606;5901.144334071536;5905.911411328833;5910.113482977587;5918.141869428909;5682.318121825366;5720.141978703186;5949.6727679977585;5955.3151387590115;5964.0457526795935;5582.7766889323975;5584.692841893735;5594.328680558318;5615.634983726045;5654.9717251413895;6084.361142080018;6114.938850611526;6143.846403839851;6144.662043587557;6149.477294429934;5561.777528898799;5565.30433695788;5796.246487956539;5868.706564671749;5876.676782776988;5550.555955523549;5846.327672317653;5910.497607703393;5990.221271234712;6007.459328660441;5601.691906945076;5807.68057756819;5812.941870581325;5821.679807610622;5838.7080645967535;5788.652680839163;5820.126980952891;5860.824175274749;5861.677607731531;5871.383504732027;4254.170436764863;4261.531231564525;4355.5426680198125;4360.629346505519;4371.628411584988;3907.5701672815967;3919.980400097981;3944.60553944609;3946.565877753445;3974.880753577397;5586.385497595261;5623.8875222496135;5624.465675760796;5624.690642014647;5627.268455100811;5755.165501002331;5796.652200867877;5909.497692696083;5917.970410148007;5941.197938278364;5617.073182924853;5705.286839145107;5725.713714314351;5768.625039372428;5773.538116950634;4964.528369804862;4973.90052198954;4978.950210497848;4988.925166122511;5030.547250747377;5840;5903.675297858659;6114.816555503342;6146.44681978633;6172.783952561639;5852.7658893645485;5857;5862.179294898632;5873.94126058751;5928.822135335947;5950.137230101524;6016;6019.879602408015;6021.849453763691;6024.1265016573225;5626.24045753818;5702.51528620072;5753.453421924911;5760.049591817303;5762.596618236683;5751.971240143773;5918.970405147947;5927;5984.8803023940145;6056.485198757979;5838.795642152504;5854.619449735754;5856.912146317723;5861.1501332307425;5863.472287494146;5620.26936498269;5669.291338582677;5760.913586296125;5793.304803423616;5796.1305804129715;5771.047777116896;5783.277090363705;5798.884022319615;5807.8548036299435;5836.533077353716;5818.330891947311;5832.183494310715;5858.560607954335;5872.677002764718;5879.059350503899;5498.835034948958;5633.690147041952;5654.293213348332;5661.320641523043;5680.261565996394 22:50:18 INFO - PROCESS | 32455 | |1;ext.html;551.1142292709044;571.2345457087504;588.4909553236452;595.8123191194774;597.3429227849365;40286.19427611446;41626.37560436596;41675;45280;45311.77344113275;42645.7867710661;43401.565984340144;43494.13011739763;43587;43629.12741745163;8436.114208008163;8666.306695464347;8676.956615216915;8692.652293908237;8728.956355218215;8886.422382545146;9001.009888912215;9024.052474490183;9038.593263303133;9044.819103617923;8903.821923561525;8909.06454822244;8914.821703565925;8931.55342232889;9005.099490051009;8922.197002269795;9028.50343231122;9033.728988130333;9060.54697265134;9064.501452420114;8804.823903521894;8808.251298639623;8908.420952638122;8913.910860891372;8914.598843052077;40755.18489630191;40933.1813363734;41027.38458923119;41090;41307.58692413067;3448.827558622059;3482.37317282889;3569.821508924543;3588.982055089708;4068.9796551017353;31045.689543104505;31058.689413105807;31254.687453125633;31328.530072048936;32901.3419731604;4353.673474489395;4464.843730469418;4492.281235002384;4535.274356103041;4549.24937385331;226727;230080;231000;231169;231475;59434.70282648559;59632.80734385288;60004.399955999885;60194;60198.39801602015;62281;62809.37190628035;62824.68587657032;62952.85235738195;63182;14730.926345368205;14929.552113436614;14941.477048303257;14957.102573845386;15006.549803505912;11321.603743868925;11528.308301501937;11551.595694150665;11555.942220289013;11566;17474.21366038506;18148;18174.18216180275;18200.45398638043;18225.362112326005;5979.252593425822;5998.220231369894;6070.7875224366935;6101.725422356005;6138.6623735694075;843.0726201178777;859.2653281444275;971.946542940145;1100.4662738571785;1166.9841964672128;30713.385732285675;30787.384252315278;31216.687833121832;31367.372652546823;31426.685733142833;965.4593427680521;1070.4054731678727;1103.4372470040337;1140.1733743036232;1154.936478493674;15971.840281597268;16146.434874779326;16201.4329498467;16209.108499032667;16273.745250949858;492697;497509;498859;500900;501008;56968;57049.429505705244;57301.71349143311;57390.139147912814;57558.13662795061;1253.7116463213513;1305.575687901436;1318.7955866840846;1319.993400033013;1322.4842311498523;27966.3008424791;29745.851270743507;30013.849930750206;30123.849380752956;30531;47962.760186198844;48081;48298;48329;48347.516524834304;342452;344134;344155;345519;345738;40221.59778402178;40426.1914761709;40479.17843697099;41699.86852563842;41819.37270940877;44842.77578612086;45137.32294015527;45763.77118114521;46468.07063858771;46698;38709.41935870908;38751.806240969745;39435.40846887356;40014.39978400384;40620.1875962485;38520;38715.80642096772;38981;39698;39846.40230396488;39068.804655976535;39119.80440097781;39662;40394.79802600968;42115;30614.387712245185;33413;33733.49399759054;33749.662503375635;33845.66154338425;27476.58785118185;27607.723922761317;27759.44481110326;27951.720482795725;28061.298467538476 22:50:18 INFO - PROCESS | 32455 | |2;jquery.html;378.6629899389542;383.995543264161;391.3249644363473;391.3620798099098;418.144893692399;16250.024998500068;17132.657346853088;17829.197686104126;19408.805911940875;19477.902610486926;18838.152283147258;19164.616707665875;19226.807731922676;19527.70708439371;19776.11007504662;5069.290299358084;5088.287639730441;5145.176771716526;5200.92198617021;5286.04851126797;5127.487251274862;5240.68555886648;5243.973780131094;5253.658512196714;5256.42179360272;5650.0959846424585;5935.673537955432;5955.868385006856;5967.671778052206;5970.34326224115;5682.261306030189;5824.679642619654;5898.1447690084915;5901.262342207224;5938.435848594377;5757.193992841006;5761.625494342854;5764.423557644244;5764.884702305931;5782.045962416196;13456.394462249222;13845.930770346184;13887.166769993833;14026.649333766636;21946.46374753768;2131.509752756859;2251.5609456156058;2266.478709896733;2311.5608034473566;2659.468106378732;9232.676856309998;10206.700354116105;10337.276390652582;14521.927390363086;14621.707565848623;1887.7923428422862;1893.1007771308655;1913.5252795092426;1937.428458604715;2020.8888511131881;79147.6042619789;82973.58513207456;85007.5749621254;85255.57372213161;85857.57071214667;10577.735556610993;10591;10903.127749779998;10947.616833410952;11018.50416731249;15153.54539363821;15161.924190379199;15171.393144274105;15187.772183417257;15218.467353642569;7145.857082858313;7388.667509962064;7516.661750221253;7731.57124203697;7998.280154786097;7005.229424763272;7134.507598085717;7335.669894854745;7353.117625884928;7365.48441609093;4568.680192386568;4623.468301145344;4627.699199552018;4656.8137274508645;4682.1338052460405;1913.8373238274623;1929.604431091623;1963.891985940787;2044.3866839947957;2050.3336415664967;828.7969447485405;910.5356268303213;950.3442624589012;989.1098011789303;989.7179303898355;18754.1560629772;19728.802711972698;19827.900860495603;19923.701144482846;20042.198312067645;957.7940742740205;980.0836218136066;984.9753756156153;1018.2922868606396;1020.7958408318218;10306.278560500694;11161.609343672932;11164.330140191452;11180.385078820744;11192;386355;391911;392562;397097;408754;64847;90411.54794225987;91266;91889.5405522968;91961.5401922986;939.6758118449261;980.2794945714894;1007.4005966449951;1008.2841182760176;1009.9293049486465;16715.74926376081;17154.142292885055;17744.51576779226;17779.555511112325;17880.731789022913;39314.410283845194;39593.20813583655;41643.58356416518;42135;42466.78766606147;53158.46841531535;53245.201321979424;53553.73223134015;54883.72558137184;56009.439905600426;7804.765857024298;7998.400119990907;8324.958375208085;8404.831903361775;8480.957595211985;11119.332840029625;11998;12243.32661703615;12370.13409061357;12437.813432798695;9594.18449431806;10146.49267536635;10959.780804383709;11225.775484490428;11695.824562631737;10701.518431670438;10790.784184316426;10854.511546980562;10887.782244355227;11079.61221357281;10735.248532602644;10826;10850.29473084247;10972.506237219504;11273.71815704614;6994.33553812387;7880.645370958206;7901.4987152443155;8101.918980810352;8123.4313598047565;10419.42693151884;10811.459427028774;10903.182261330274;10973;11451 22:50:18 INFO - PROCESS | 32455 | |3;mootools.html;1497.3336865095037;1519.9392024319027;1685.3595633659208;1785.1966615023243;1803.9188236529355;8150.3887208459455;8172.795680107993;8412.747617571467;8728.170823771747;8820.382573219877;8761.912380876189;9127.908720912788;9131.543422828849;9275.30435217358;9433.433993960367;2273.12484693393;2332.8716920569364;2362.633791762271;2365.396823809926;2369.052379048377;2298.19563152896;2307.157887371114;2348.6829278047503;2360.4570948681812;2371.490129622131;2278.4759505313787;2287.2795069553035;2299.793018628323;2331.708536432946;2342.309018839438;2279.763998355315;2281.258590957929;2283.4519715268384;2286.0741399733133;2298.5058212484314;2282.1213832674375;2290.5647926894003;2293.7591552886875;2295.8048565871923;2297.287840769367;9253.583588738524;9298.488583127924;9362.157405833508;9368.718938431857;9414.670486533007;5289.894202115975;5397;5424.674519528801;5447.727613619303;5463.590230732671;3269.215388306813;3300.1089705779546;3453.1367158210446;3461;3495.94756078659;1036.7874585709912;1038.3717850700293;1053.1311667874033;1056.1234175634281;1073.2755390111722;13020.674483137902;13043.217406955519;13172.341382930816;13173.275469849155;13213.603591892163;4421.098927461158;4627.213373726475;4667.509911459316;4712.434507859079;4714.127886341038;10912;10919.727006824734;10958.780824383468;10971.561137554569;11043;5439.9936011837935;5440;5444.5916556258435;5452.945470545244;5458.4814442627885;4356.607905288539;4493.932591011137;4716.245400735866;4856.95143048565;5011.022850544182;3884.4561761353434;3991.660708839723;4028.2547728669706;4094.6928980326593;4101.282275601758;1244.520859469111;1263.387257180267;1268.3911722373311;1273.9554115605908;1281.814136950137;935.1910597333258;979.1187930862138;986.7779749556292;990.2226751999646;995.9402435853872;5986.910196347058;5987.221661184019;6155.138280640714;6172.598781079216;6198.597091189058;434.9478062632441;439.48141193392104;439.9890002749893;979.2900147393225;992.2409356842022;4084.9795751021056;4195.496540415109;4233.5131459882505;4236.894077648022;4258.914821703549;11183.776324473465;11591.188616796744;11635.301881887113;11641.76716465666;11679.649610511698;11449.942750286194;11471.426428678533;11485.540578376938;11514.596989105508;11539.71150721222;8504.362172836938;8565.357598180162;8706.477611343213;8707.564621768886;8737.737867863974;6065.484433822998;6187;6193.102000209854;6211.596246243979;6240.968795155995;10570.682879513626;10628.734281642712;10722.088622467178;10740.73148171302;10798.946005269923;10498.740151181906;10670.46647667629;10852.511636976196;10908.454577271263;11076.889231107585;6967.930320696728;7177.964110179416;7477.40180785525;7649.120351159465;7697.846043079219;8753.431026983226;9056.094390560891;9084.40951338161;9087.954560227157;9103.317251206054;7832.099308579586;7907.090684571348;7978.640961156646;8071.394645401501;8197.836043278981;7955;8047.436679432383;8096.230858068474;8160.183981601793;8263.091059983277;7407.296306850841;7437.851242975218;7465.06686664167;7534.171241163577;7539.1706912238515;5196.870078248074;5369.919451208157;5411.945880541144;5419;5586.636868603528;5306.575473962151;5313.946860531345;5336.946630533645;5369;5443.918341224806 22:50:18 INFO - PROCESS | 32455 | |4;prototype.html;327.9245773472101;332.7388000419671;338.2119661189429;340.3618215845289;345.1939720752044;5325.866853328659;5469.535089517386;5495.587830912677;5575.804846830361;5625.887482250358;5239.973800131003;5364.651297665649;5440.564754819605;5455.645383050099;5466.590005749565;4305.45977873054;4317.222899878021;4317.352397140438;4321.524632290446;4323.113761678848;4181.981865478259;4230.4500414946015;4311.353297005443;4327.783610819446;4329.731053054955;4273.230818452677;4278;4281.828726850922;4292.957070429303;4300.806463709125;4280.122574872159;4301;4317.719348242385;4322.876052226444;4337;3720.251481803548;3855.8072096395067;3859.2667393195484;3864.478295430109;3870.3420418528917;5322.866928326784;5326.174442961347;5337.092694241988;5343.412224655285;5350.5184533392185;4876.293297345936;4886.631743111934;4902.632302577321;4905.068037072945;4905.3623029006;5497.752601132958;5636.633618814764;5657.708628005665;5738.540916726652;5754.510866576346;4142.91714165715;4143.6685065195015;4156.501219853637;4182.832686692559;4192.81132349045;5990.8502287442725;6022.488088512482;6027.186329845503;6048.395160483917;6056.485878530368;3957.3074711925296;4203.43253660758;4318.784060796947;4319.438472998553;4320.870373888788;4179.937300940488;4221.978890105591;4231.8730438086295;4239.745615263094;4242.618164365222;4887.340209071801;4889.266610008527;4922.458529561745;4923.507649235048;4937.23472861707;5615.410381909923;5694.145878118233;5855.130985817004;5886.764529418861;5893.263342082239;1467.8311994120813;1504.706582216479;1509.4943194029904;1515.6892836968395;1517.446132161753;916.3127654259306;951.4338968313842;953.270747877874;965.1747755668943;967.862761255522;4841.975790121027;4866.513348665105;4881.658283920092;4890.682105663192;4924.901501969941;5129.487051294916;5192.402873669576;5213.895722085537;5221.921671174935;5282.207668849626;4785.545373189541;4913.557779799764;4939.56752541766;4967;5000.3249561309485;2752.2844060544403;2758.2828464598947;2761.8619069046467;2766.7233276672573;2772.5979732938613;5307.6284660073425;5351.983123206656;5365;5393.867287869512;5419.783208671688;4873.366462359871;5256.684598924076;5268.578513718893;5326.6005049621435;5346.946530534723;5271.947280527223;5280.653433374465;5287.656302340336;5301.337332833319;5328.520433161034;5143.819966301311;5148.970205958748;5195.765820696985;5200.401953775364;5228.947710522846;5113.539781419541;5427.728613569385;5795.449432303924;5894.70526473666;5941.673207973603;6215.285242197205;6229.414792861093;6274.403931626488;6280.842978925563;6296.811095667137;3973.6225058619384;4217.409562661292;4226.4083028375435;4236.195122926634;4247.830086796494;5717.313922329347;5893.3204036851;5906.468417842415;5924.526037917042;5942.910856337072;5802.245708057925;5818.912716309174;5842.883142337215;5845.473907348359;5954.37479064692;5827.271591051119;5835.854103647443;5836.328822185503;5847.473727364558;5867.970660146672;5587.385387607441;5739.942600574108;5769.701817091121;5779.2775903012125;5787.247657804627;5791.333996590446;5792.333881603669;5833.358330583717;5878.559108066997;5898.08045017719;5183.667349692578;5524.790083966445;5639.154126881001;5655.886882262414;5693.3168019837885 22:50:18 INFO - PROCESS | 32455 | |5;yui.html;706.9116360454943;736.0357931110243;741.7848823841085;771.3944553525483;849.4351256414483;15450.845491545082;16244.918775406106;16660.333586656518;16786.91606541967;17310.394136205236;14465.481124481936;14712.779308310384;14759.631009224775;14765.335559899804;14782;799.7680672604938;816.6243527977138;820.7127505373102;821.1008945204991;821.2485575698229;793.0800271684847;818.8526065308242;819.5410570080744;822.3298012120133;823.3742355809597;864.8313578852126;864.9005364383114;865.7705707987388;869.1178453869328;871.4161511787117;860.475110182788;861.3582880753847;864.7535452396099;865.4071960706905;865.6926790989171;628.8868003759321;632.3771085480797;632.5129650169343;632.7279269913935;635.0220660183312;15976.121313327762;15986.12076335801;16003.919980400024;16030.35878564856;16048.75926861098;14778;14803.18582477974;14888.34489188478;15032.624184395369;15104.848951510565;11846.268425445956;11879.22785018971;11897.762044759056;12021.338826364547;12651.873481265253;3692.576610039868;3840.6543411092857;3849.8267577958777;3913.25648126855;3973.284808734427;77774.61112694457;79639.6018019912;79735.60132199302;80119;81024.59487702524;10914;11075.50160242791;11090.279131856403;11221.438928053565;11568.132390070778;20590.382288531368;20612.072456739483;20614.381568552668;20717.0677319521;20722.171113155608;7850.450468467267;7913.287804097658;7958.442908996431;8207.425480216327;8244.917550824535;4834.827398345784;4835.0571638530855;4909.091818013679;5001.999600079998;5002.074616196015;3630.582483014487;3749.5875453700073;3757.530308711411;3767.547894252707;3776.5090538229856;641.6695401868042;658.9785831960443;659.0378048049805;666.9933300666931;671.835400326923;616.8827922694674;631.8104568629393;659.5317324699421;664.3489380407228;733.6258508160877;8923;9275.211607013345;9502.619895204252;9617.374870633526;9747.853782193273;647.8283254937445;657.8322527755391;687.5049964025893;700.1493185779302;739.6597565119997;4356.912861742748;4778.283257511401;4873.463918968911;4893.7063776173545;5046.59627229828;59510;60754;107226.46386768016;112223.21656226143;114859;93431;96033.51983240039;99068;99704;100252;77955;86668;87798.56100719456;87853.12146878577;87906.56046719853;9307.177797743998;9343.439393636403;9733.80532389334;9744.902550974683;9783.902160978583;48005.27992080191;48255.75872120617;49779.502204977485;49804;50806.491935081656;43459.34810977775;44062.11875762531;68229;71126.15495380126;74672.42577400511;11540.769184616092;11850.348230847387;11890.464929078385;12192.87807121953;12596.748065038832;13401.396937138048;13442.395092220679;13506.122102063335;13839.792403113759;14221.14673119616;10812.729681758019;11050.668479945614;11181.552737890393;11440.656780296604;11589.768204635691;11710;12178.939105304771;12758.298293593942;12775.425105870445;12806.743865122831;12609.621711348675;12726.490940362652;13036.739265214832;13079.476820927057;13538.79691804604;9294.442333460014;9327.253819694273;9830.606775728891;9963.153131983572;10118.038786315288;10070.345427547187;10546.894531054591;10637.202209834139;10650.520726567169;10745.94627026891 22:50:18 INFO - PROCESS | 32455 | __end_tp_report 22:50:18 INFO - PROCESS | 32455 | __start_cc_report 22:50:18 INFO - PROCESS | 32455 | _x_x_mozilla_cycle_collect,314 22:50:18 INFO - PROCESS | 32455 | __end_cc_report 22:50:18 INFO - PROCESS | 32455 | __startTimestamp1477288218790__endTimestamp 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | ------- Summary: start ------- 22:50:18 INFO - PROCESS | 32455 | Number of tests: 6 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#0] dojo.html Cycles:165 Average:5469.52 Median:5680.26 stddev:634.29 (11.2%) stddev-sans-first:609.66 22:50:18 INFO - PROCESS | 32455 | Values: 3153.6 3170.0 3190.2 3198.4 3200.9 5322.2 5489.5 5503.4 5532.1 5569.8 5374.8 5479.9 5493.5 5536.3 5601.1 4998.2 5021.3 5083.9 5118.0 5154.6 5047.3 5135.4 5153.7 5156.4 5218.7 4950.8 4952.4 5049.7 5066.3 5131.2 5008.1 5012.3 5016.0 5020.5 5025.3 4936.7 4956.1 5011.5 5017.4 5047.8 5447.3 5471.3 5513.9 5515.0 5528.3 5892.1 5901.1 5905.9 5910.1 5918.1 5682.3 5720.1 5949.7 5955.3 5964.0 5582.8 5584.7 5594.3 5615.6 5655.0 6084.4 6114.9 6143.8 6144.7 6149.5 5561.8 5565.3 5796.2 5868.7 5876.7 5550.6 5846.3 5910.5 5990.2 6007.5 5601.7 5807.7 5812.9 5821.7 5838.7 5788.7 5820.1 5860.8 5861.7 5871.4 4254.2 4261.5 4355.5 4360.6 4371.6 3907.6 3920.0 3944.6 3946.6 3974.9 5586.4 5623.9 5624.5 5624.7 5627.3 5755.2 5796.7 5909.5 5918.0 5941.2 5617.1 5705.3 5725.7 5768.6 5773.5 4964.5 4973.9 4979.0 4988.9 5030.5 5840.0 5903.7 6114.8 6146.4 6172.8 5852.8 5857.0 5862.2 5873.9 5928.8 5950.1 6016.0 6019.9 6021.8 6024.1 5626.2 5702.5 5753.5 5760.0 5762.6 5752.0 5919.0 5927.0 5984.9 6056.5 5838.8 5854.6 5856.9 5861.2 5863.5 5620.3 5669.3 5760.9 5793.3 5796.1 5771.0 5783.3 5798.9 5807.9 5836.5 5818.3 5832.2 5858.6 5872.7 5879.1 5498.8 5633.7 5654.3 5661.3 5680.3 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#1] ext.html Cycles:180 Average:53051.40 Median:40980.28 stddev:99098.44 (241.8%) stddev-sans-first:99298.04 22:50:18 INFO - PROCESS | 32455 | Values: 551.1 571.2 588.5 595.8 597.3 40286.2 41626.4 41675.0 45280.0 45311.8 42645.8 43401.6 43494.1 43587.0 43629.1 8436.1 8666.3 8677.0 8692.7 8729.0 8886.4 9001.0 9024.1 9038.6 9044.8 8903.8 8909.1 8914.8 8931.6 9005.1 8922.2 9028.5 9033.7 9060.5 9064.5 8804.8 8808.3 8908.4 8913.9 8914.6 40755.2 40933.2 41027.4 41090.0 41307.6 3448.8 3482.4 3569.8 3589.0 4069.0 31045.7 31058.7 31254.7 31328.5 32901.3 4353.7 4464.8 4492.3 4535.3 4549.2 226727.0 230080.0 231000.0 231169.0 231475.0 59434.7 59632.8 60004.4 60194.0 60198.4 62281.0 62809.4 62824.7 62952.9 63182.0 14730.9 14929.6 14941.5 14957.1 15006.5 11321.6 11528.3 11551.6 11555.9 11566.0 17474.2 18148.0 18174.2 18200.5 18225.4 5979.3 5998.2 6070.8 6101.7 6138.7 843.1 859.3 971.9 1100.5 1167.0 30713.4 30787.4 31216.7 31367.4 31426.7 965.5 1070.4 1103.4 1140.2 1154.9 15971.8 16146.4 16201.4 16209.1 16273.7 492697.0 497509.0 498859.0 500900.0 501008.0 56968.0 57049.4 57301.7 57390.1 57558.1 1253.7 1305.6 1318.8 1320.0 1322.5 27966.3 29745.9 30013.8 30123.8 30531.0 47962.8 48081.0 48298.0 48329.0 48347.5 342452.0 344134.0 344155.0 345519.0 345738.0 40221.6 40426.2 40479.2 41699.9 41819.4 44842.8 45137.3 45763.8 46468.1 46698.0 38709.4 38751.8 39435.4 40014.4 40620.2 38520.0 38715.8 38981.0 39698.0 39846.4 39068.8 39119.8 39662.0 40394.8 42115.0 30614.4 33413.0 33733.5 33749.7 33845.7 27476.6 27607.7 27759.4 27951.7 28061.3 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#2] jquery.html Cycles:180 Average:25756.41 Median:193373.16 stddev:65781.02 (34.0%) stddev-sans-first:65937.95 22:50:18 INFO - PROCESS | 32455 | Values: 378.7 384.0 391.3 391.4 418.1 16250.0 17132.7 17829.2 19408.8 19477.9 18838.2 19164.6 19226.8 19527.7 19776.1 5069.3 5088.3 5145.2 5200.9 5286.0 5127.5 5240.7 5244.0 5253.7 5256.4 5650.1 5935.7 5955.9 5967.7 5970.3 5682.3 5824.7 5898.1 5901.3 5938.4 5757.2 5761.6 5764.4 5764.9 5782.0 13456.4 13845.9 13887.2 14026.6 21946.5 2131.5 2251.6 2266.5 2311.6 2659.5 9232.7 10206.7 10337.3 14521.9 14621.7 1887.8 1893.1 1913.5 1937.4 2020.9 79147.6 82973.6 85007.6 85255.6 85857.6 10577.7 10591.0 10903.1 10947.6 11018.5 15153.5 15161.9 15171.4 15187.8 15218.5 7145.9 7388.7 7516.7 7731.6 7998.3 7005.2 7134.5 7335.7 7353.1 7365.5 4568.7 4623.5 4627.7 4656.8 4682.1 1913.8 1929.6 1963.9 2044.4 2050.3 828.8 910.5 950.3 989.1 989.7 18754.2 19728.8 19827.9 19923.7 20042.2 957.8 980.1 985.0 1018.3 1020.8 10306.3 11161.6 11164.3 11180.4 11192.0 386355.0 391911.0 392562.0 397097.0 408754.0 64847.0 90411.5 91266.0 91889.5 91961.5 939.7 980.3 1007.4 1008.3 1009.9 16715.7 17154.1 17744.5 17779.6 17880.7 39314.4 39593.2 41643.6 42135.0 42466.8 53158.5 53245.2 53553.7 54883.7 56009.4 7804.8 7998.4 8325.0 8404.8 8481.0 11119.3 11998.0 12243.3 12370.1 12437.8 9594.2 10146.5 10959.8 11225.8 11695.8 10701.5 10790.8 10854.5 10887.8 11079.6 10735.2 10826.0 10850.3 10972.5 11273.7 6994.3 7880.6 7901.5 8101.9 8123.4 10419.4 10811.5 10903.2 10973.0 11451.0 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#3] mootools.html Cycles:180 Average:6005.12 Median:4560.57 stddev:3522.39 (77.2%) stddev-sans-first:3515.99 22:50:18 INFO - PROCESS | 32455 | Values: 1497.3 1519.9 1685.4 1785.2 1803.9 8150.4 8172.8 8412.7 8728.2 8820.4 8761.9 9127.9 9131.5 9275.3 9433.4 2273.1 2332.9 2362.6 2365.4 2369.1 2298.2 2307.2 2348.7 2360.5 2371.5 2278.5 2287.3 2299.8 2331.7 2342.3 2279.8 2281.3 2283.5 2286.1 2298.5 2282.1 2290.6 2293.8 2295.8 2297.3 9253.6 9298.5 9362.2 9368.7 9414.7 5289.9 5397.0 5424.7 5447.7 5463.6 3269.2 3300.1 3453.1 3461.0 3495.9 1036.8 1038.4 1053.1 1056.1 1073.3 13020.7 13043.2 13172.3 13173.3 13213.6 4421.1 4627.2 4667.5 4712.4 4714.1 10912.0 10919.7 10958.8 10971.6 11043.0 5440.0 5440.0 5444.6 5452.9 5458.5 4356.6 4493.9 4716.2 4857.0 5011.0 3884.5 3991.7 4028.3 4094.7 4101.3 1244.5 1263.4 1268.4 1274.0 1281.8 935.2 979.1 986.8 990.2 995.9 5986.9 5987.2 6155.1 6172.6 6198.6 434.9 439.5 440.0 979.3 992.2 4085.0 4195.5 4233.5 4236.9 4258.9 11183.8 11591.2 11635.3 11641.8 11679.6 11449.9 11471.4 11485.5 11514.6 11539.7 8504.4 8565.4 8706.5 8707.6 8737.7 6065.5 6187.0 6193.1 6211.6 6241.0 10570.7 10628.7 10722.1 10740.7 10798.9 10498.7 10670.5 10852.5 10908.5 11076.9 6967.9 7178.0 7477.4 7649.1 7697.8 8753.4 9056.1 9084.4 9088.0 9103.3 7832.1 7907.1 7978.6 8071.4 8197.8 7955.0 8047.4 8096.2 8160.2 8263.1 7407.3 7437.9 7465.1 7534.2 7539.2 5196.9 5369.9 5411.9 5419.0 5586.6 5306.6 5313.9 5336.9 5369.0 5443.9 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#4] prototype.html Cycles:180 Average:4709.07 Median:5225.43 stddev:1370.63 (26.2%) stddev-sans-first:1334.45 22:50:18 INFO - PROCESS | 32455 | Values: 327.9 332.7 338.2 340.4 345.2 5325.9 5469.5 5495.6 5575.8 5625.9 5240.0 5364.7 5440.6 5455.6 5466.6 4305.5 4317.2 4317.4 4321.5 4323.1 4182.0 4230.5 4311.4 4327.8 4329.7 4273.2 4278.0 4281.8 4293.0 4300.8 4280.1 4301.0 4317.7 4322.9 4337.0 3720.3 3855.8 3859.3 3864.5 3870.3 5322.9 5326.2 5337.1 5343.4 5350.5 4876.3 4886.6 4902.6 4905.1 4905.4 5497.8 5636.6 5657.7 5738.5 5754.5 4142.9 4143.7 4156.5 4182.8 4192.8 5990.9 6022.5 6027.2 6048.4 6056.5 3957.3 4203.4 4318.8 4319.4 4320.9 4179.9 4222.0 4231.9 4239.7 4242.6 4887.3 4889.3 4922.5 4923.5 4937.2 5615.4 5694.1 5855.1 5886.8 5893.3 1467.8 1504.7 1509.5 1515.7 1517.4 916.3 951.4 953.3 965.2 967.9 4842.0 4866.5 4881.7 4890.7 4924.9 5129.5 5192.4 5213.9 5221.9 5282.2 4785.5 4913.6 4939.6 4967.0 5000.3 2752.3 2758.3 2761.9 2766.7 2772.6 5307.6 5352.0 5365.0 5393.9 5419.8 4873.4 5256.7 5268.6 5326.6 5346.9 5271.9 5280.7 5287.7 5301.3 5328.5 5143.8 5149.0 5195.8 5200.4 5228.9 5113.5 5427.7 5795.4 5894.7 5941.7 6215.3 6229.4 6274.4 6280.8 6296.8 3973.6 4217.4 4226.4 4236.2 4247.8 5717.3 5893.3 5906.5 5924.5 5942.9 5802.2 5818.9 5842.9 5845.5 5954.4 5827.3 5835.9 5836.3 5847.5 5868.0 5587.4 5739.9 5769.7 5779.3 5787.2 5791.3 5792.3 5833.4 5878.6 5898.1 5183.7 5524.8 5639.2 5655.9 5693.3 22:50:18 INFO - PROCESS | 32455 | 22:50:18 INFO - PROCESS | 32455 | [#5] yui.html Cycles:180 Average:19534.24 Median:27344.30 stddev:27790.65 (101.6%) stddev-sans-first:27832.66 22:50:18 INFO - PROCESS | 32455 | Values: 706.9 736.0 741.8 771.4 849.4 15450.8 16244.9 16660.3 16786.9 17310.4 14465.5 14712.8 14759.6 14765.3 14782.0 799.8 816.6 820.7 821.1 821.2 793.1 818.9 819.5 822.3 823.4 864.8 864.9 865.8 869.1 871.4 860.5 861.4 864.8 865.4 865.7 628.9 632.4 632.5 632.7 635.0 15976.1 15986.1 16003.9 16030.4 16048.8 14778.0 14803.2 14888.3 15032.6 15104.8 11846.3 11879.2 11897.8 12021.3 12651.9 3692.6 3840.7 3849.8 3913.3 3973.3 77774.6 79639.6 79735.6 80119.0 81024.6 10914.0 11075.5 11090.3 11221.4 11568.1 20590.4 20612.1 20614.4 20717.1 20722.2 7850.5 7913.3 7958.4 8207.4 8244.9 4834.8 4835.1 4909.1 5002.0 5002.1 3630.6 3749.6 3757.5 3767.5 3776.5 641.7 659.0 659.0 667.0 671.8 616.9 631.8 659.5 664.3 733.6 8923.0 9275.2 9502.6 9617.4 9747.9 647.8 657.8 687.5 700.1 739.7 4356.9 4778.3 4873.5 4893.7 5046.6 59510.0 60754.0 107226.5 112223.2 114859.0 93431.0 96033.5 99068.0 99704.0 100252.0 77955.0 86668.0 87798.6 87853.1 87906.6 9307.2 9343.4 9733.8 9744.9 9783.9 48005.3 48255.8 49779.5 49804.0 50806.5 43459.3 44062.1 68229.0 71126.2 74672.4 11540.8 11850.3 11890.5 12192.9 12596.7 13401.4 13442.4 13506.1 13839.8 14221.1 10812.7 11050.7 11181.6 11440.7 11589.8 11710.0 12178.9 12758.3 12775.4 12806.7 12609.6 12726.5 13036.7 13079.5 13538.8 9294.4 9327.3 9830.6 9963.2 10118.0 10070.3 10546.9 10637.2 10650.5 10745.9 22:50:18 INFO - PROCESS | 32455 | -------- Summary: end -------- 22:50:18 INFO - PROCESS | 32455 | 22:50:19 INFO - TEST-INFO | 32455: exit 0 22:50:19 INFO - TEST-OK | dromaeo_css | took 1116813ms 22:50:19 INFO - TEST-START | kraken 22:50:19 INFO - operating with platform_type : linux_ 22:50:19 INFO - Initialising browser for kraken test... 22:50:19 INFO - TEST-INFO | started process 349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsdKQg/profile http://localhost:51793/getInfo.html) 22:50:24 INFO - PROCESS | 349 | __metrics Screen width/height:1600/1200 22:50:24 INFO - PROCESS | 349 | colorDepth:24 22:50:24 INFO - PROCESS | 349 | Browser inner width/height: 1024/697 22:50:24 INFO - PROCESS | 349 | __metrics 22:50:24 ERROR - PROCESS | 349 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3097: TypeError: this.tabs is undefined 22:50:25 INFO - TEST-INFO | 349: exit 0 22:50:25 INFO - Browser initialized. 22:50:25 INFO - Running cycle 1/1 for kraken test... 22:50:25 INFO - TEST-INFO | started process 474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdsdKQg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:50:37 INFO - PROCESS | 474 | RSS: Main: 183443456 22:50:37 INFO - PROCESS | 474 | 22:50:40 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51793/tests/kraken/driver.html?testName=audio-beat-detection) 22:50:41 INFO - PROCESS | 474 | RSS: Main: 197681152 22:50:41 INFO - PROCESS | 474 | 22:50:44 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51793/tests/kraken/driver.html?testName=audio-dft) 22:50:44 INFO - PROCESS | 474 | RSS: Main: 194998272 22:50:44 INFO - PROCESS | 474 | 22:50:47 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51793/tests/kraken/driver.html?testName=audio-fft) 22:50:48 INFO - PROCESS | 474 | RSS: Main: 191860736 22:50:48 INFO - PROCESS | 474 | 22:50:50 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51793/tests/kraken/driver.html?testName=audio-oscillator) 22:50:51 INFO - PROCESS | 474 | RSS: Main: 192360448 22:50:51 INFO - PROCESS | 474 | 22:50:53 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51793/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:50:53 INFO - PROCESS | 474 | RSS: Main: 192585728 22:50:53 INFO - PROCESS | 474 | 22:50:56 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51793/tests/kraken/driver.html?testName=imaging-darkroom) 22:50:57 INFO - PROCESS | 474 | RSS: Main: 193011712 22:50:57 INFO - PROCESS | 474 | 22:51:00 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51793/tests/kraken/driver.html?testName=imaging-desaturate) 22:51:01 INFO - PROCESS | 474 | RSS: Main: 193290240 22:51:01 INFO - PROCESS | 474 | 22:51:04 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51793/tests/kraken/driver.html?testName=json-parse-financial) 22:51:04 INFO - PROCESS | 474 | RSS: Main: 193155072 22:51:04 INFO - PROCESS | 474 | 22:51:06 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51793/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:51:07 INFO - PROCESS | 474 | RSS: Main: 193134592 22:51:07 INFO - PROCESS | 474 | 22:51:08 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:51:09 INFO - PROCESS | 474 | RSS: Main: 193081344 22:51:09 INFO - PROCESS | 474 | 22:51:11 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:51:12 INFO - PROCESS | 474 | RSS: Main: 193359872 22:51:12 INFO - PROCESS | 474 | 22:51:14 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:51:15 INFO - PROCESS | 474 | RSS: Main: 193384448 22:51:15 INFO - PROCESS | 474 | 22:51:18 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:51:19 INFO - PROCESS | 474 | RSS: Main: 193769472 22:51:19 INFO - PROCESS | 474 | 22:51:20 INFO - PROCESS | 474 | Cycle 1(1): loaded http://localhost:51793/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51793/tests/kraken/driver.html?testName=ai-astar) 22:51:21 INFO - PROCESS | 474 | RSS: Main: 195063808 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | __start_tp_report 22:51:21 INFO - PROCESS | 474 | _x_x_mozilla_page_load 22:51:21 INFO - PROCESS | 474 | _x_x_mozilla_page_load_details 22:51:21 INFO - PROCESS | 474 | |i|pagename|runs| 22:51:21 INFO - PROCESS | 474 | |0;ai-astar;104;111;113;112;112;111;111;111;110;113 22:51:21 INFO - PROCESS | 474 | |1;audio-beat-detection;157;123;129;170;125;126;126;123;154;125 22:51:21 INFO - PROCESS | 474 | |2;audio-dft;162;164;164;167;167;163;161;162;163;162 22:51:21 INFO - PROCESS | 474 | |3;audio-fft;76;75;75;106;75;76;77;77;110;76 22:51:21 INFO - PROCESS | 474 | |4;audio-oscillator;83;84;105;84;83;82;103;82;84;104 22:51:21 INFO - PROCESS | 474 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;118;120 22:51:21 INFO - PROCESS | 474 | |6;imaging-darkroom;147;148;147;147;147;147;147;149;149;147 22:51:21 INFO - PROCESS | 474 | |7;imaging-desaturate;85;85;85;85;85;86;84;86;86;85 22:51:21 INFO - PROCESS | 474 | |8;json-parse-financial;60;54;53;53;54;54;53;54;54;66 22:51:21 INFO - PROCESS | 474 | |9;json-stringify-tinderbox;61;60;60;60;60;59;60;61;60;60 22:51:21 INFO - PROCESS | 474 | |10;stanford-crypto-aes;81;82;81;80;82;90;82;81;79;82 22:51:21 INFO - PROCESS | 474 | |11;stanford-crypto-ccm;144;130;137;131;131;137;142;132;169;130 22:51:21 INFO - PROCESS | 474 | |12;stanford-crypto-pbkdf2;174;167;169;166;168;168;164;167;166;167 22:51:21 INFO - PROCESS | 474 | |13;stanford-crypto-sha256-iterative;68;68;67;65;66;71;66;78;65;65 22:51:21 INFO - PROCESS | 474 | __end_tp_report 22:51:21 INFO - PROCESS | 474 | __start_cc_report 22:51:21 INFO - PROCESS | 474 | _x_x_mozilla_cycle_collect,819 22:51:21 INFO - PROCESS | 474 | __end_cc_report 22:51:21 INFO - PROCESS | 474 | __startTimestamp1477288281121__endTimestamp 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | ------- Summary: start ------- 22:51:21 INFO - PROCESS | 474 | Number of tests: 14 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.57 (2.3%) stddev-sans-first:1.01 22:51:21 INFO - PROCESS | 474 | Values: 104.0 111.0 113.0 112.0 112.0 111.0 111.0 111.0 110.0 113.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:127.50 stddev:17.48 (13.7%) stddev-sans-first:16.77 22:51:21 INFO - PROCESS | 474 | Values: 157.0 123.0 129.0 170.0 125.0 126.0 126.0 123.0 154.0 125.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.07 (1.3%) stddev-sans-first:2.12 22:51:21 INFO - PROCESS | 474 | Values: 162.0 164.0 164.0 167.0 167.0 163.0 161.0 162.0 163.0 162.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.60 (17.9%) stddev-sans-first:14.23 22:51:21 INFO - PROCESS | 474 | Values: 76.0 75.0 75.0 106.0 75.0 76.0 77.0 77.0 110.0 76.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:83.00 stddev:10.11 (12.2%) stddev-sans-first:10.46 22:51:21 INFO - PROCESS | 474 | Values: 83.0 84.0 105.0 84.0 83.0 82.0 103.0 82.0 84.0 104.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.97 22:51:21 INFO - PROCESS | 474 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 120.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 22:51:21 INFO - PROCESS | 474 | Values: 147.0 148.0 147.0 147.0 147.0 147.0 147.0 149.0 149.0 147.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:51:21 INFO - PROCESS | 474 | Values: 85.0 85.0 85.0 85.0 85.0 86.0 84.0 86.0 86.0 85.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:4.22 (7.8%) stddev-sans-first:4.15 22:51:21 INFO - PROCESS | 474 | Values: 60.0 54.0 53.0 53.0 54.0 54.0 53.0 54.0 54.0 66.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 22:51:21 INFO - PROCESS | 474 | Values: 61.0 60.0 60.0 60.0 60.0 59.0 60.0 61.0 60.0 60.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:2.98 (3.6%) stddev-sans-first:3.14 22:51:21 INFO - PROCESS | 474 | Values: 81.0 82.0 81.0 80.0 82.0 90.0 82.0 81.0 79.0 82.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:11.91 (8.7%) stddev-sans-first:12.45 22:51:21 INFO - PROCESS | 474 | Values: 144.0 130.0 137.0 131.0 131.0 137.0 142.0 132.0 169.0 130.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:167.50 stddev:2.63 (1.6%) stddev-sans-first:1.45 22:51:21 INFO - PROCESS | 474 | Values: 174.0 167.0 169.0 166.0 168.0 168.0 164.0 167.0 166.0 167.0 22:51:21 INFO - PROCESS | 474 | 22:51:21 INFO - PROCESS | 474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:67.50 stddev:4.01 (5.9%) stddev-sans-first:4.26 22:51:21 INFO - PROCESS | 474 | Values: 68.0 68.0 67.0 65.0 66.0 71.0 66.0 78.0 65.0 65.0 22:51:21 INFO - PROCESS | 474 | -------- Summary: end -------- 22:51:21 INFO - PROCESS | 474 | 22:51:22 INFO - TEST-INFO | 474: exit 0 22:51:22 INFO - TEST-OK | kraken | took 62407ms 22:51:22 INFO - SUITE-END | took 1179s 22:51:22 INFO - Completed test suite (00:19:39) 22:51:22 INFO - javascript benchmark 22:51:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7183.908890857841, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.5585018097463, 3170.048985304411, 3190.234343757499, 3198.3923054619604, 3200.879692107762, 5322.228276899857, 5489.478499542542, 5503.367112782032, 5532.059549876521, 5569.777208911649, 5374.811881584145, 5479.945200547993, 5493.533049690771, 5536.280283563131, 5601.075822489294, 4998.150314446535, 5021.297018417425, 5083.872903177413, 5117.974410127963, 5154.6134039946965, 5047.31861198739, 5135.383753949532, 5153.660048387427, 5156.381234251895, 5218.712970786605, 4950.752462376903, 4952.380952380952, 5049.747512624354, 5066.290719299301, 5131.153359695664, 5008.073506401327, 5012.298278241049, 5016.04695107932, 5020.523050310251, 5025.271335656309, 4936.728479933602, 4956.058348913695, 5011.548960593527, 5017.448080711155, 5047.772850221749, 5447.264619276387, 5471.316085489314, 5513.917291240595, 5514.972425137888, 5528.253685752412, 5892.116182572606, 5901.144334071536, 5905.911411328833, 5910.113482977587, 5918.141869428909, 5682.318121825366, 5720.141978703186, 5949.6727679977585, 5955.3151387590115, 5964.0457526795935, 5582.7766889323975, 5584.692841893735, 5594.328680558318, 5615.634983726045, 5654.9717251413895, 6084.361142080018, 6114.938850611526, 6143.846403839851, 6144.662043587557, 6149.477294429934, 5561.777528898799, 5565.30433695788, 5796.246487956539, 5868.706564671749, 5876.676782776988, 5550.555955523549, 5846.327672317653, 5910.497607703393, 5990.221271234712, 6007.459328660441, 5601.691906945076, 5807.68057756819, 5812.941870581325, 5821.679807610622, 5838.7080645967535, 5788.652680839163, 5820.126980952891, 5860.824175274749, 5861.677607731531, 5871.383504732027, 4254.170436764863, 4261.531231564525, 4355.5426680198125, 4360.629346505519, 4371.628411584988, 3907.5701672815967, 3919.980400097981, 3944.60553944609, 3946.565877753445, 3974.880753577397, 5586.385497595261, 5623.8875222496135, 5624.465675760796, 5624.690642014647, 5627.268455100811, 5755.165501002331, 5796.652200867877, 5909.497692696083, 5917.970410148007, 5941.197938278364, 5617.073182924853, 5705.286839145107, 5725.713714314351, 5768.625039372428, 5773.538116950634, 4964.528369804862, 4973.90052198954, 4978.950210497848, 4988.925166122511, 5030.547250747377, 5840.0, 5903.675297858659, 6114.816555503342, 6146.44681978633, 6172.783952561639, 5852.7658893645485, 5857.0, 5862.179294898632, 5873.94126058751, 5928.822135335947, 5950.137230101524, 6016.0, 6019.879602408015, 6021.849453763691, 6024.1265016573225, 5626.24045753818, 5702.51528620072, 5753.453421924911, 5760.049591817303, 5762.596618236683, 5751.971240143773, 5918.970405147947, 5927.0, 5984.8803023940145, 6056.485198757979, 5838.795642152504, 5854.619449735754, 5856.912146317723, 5861.1501332307425, 5863.472287494146, 5620.26936498269, 5669.291338582677, 5760.913586296125, 5793.304803423616, 5796.1305804129715, 5771.047777116896, 5783.277090363705, 5798.884022319615, 5807.8548036299435, 5836.533077353716, 5818.330891947311, 5832.183494310715, 5858.560607954335, 5872.677002764718, 5879.059350503899, 5498.835034948958, 5633.690147041952, 5654.293213348332, 5661.320641523043, 5680.261565996394], "value": 5425.722326866294, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1142292709044, 571.2345457087504, 588.4909553236452, 595.8123191194774, 597.3429227849365, 40286.19427611446, 41626.37560436596, 41675.0, 45280.0, 45311.77344113275, 42645.7867710661, 43401.565984340144, 43494.13011739763, 43587.0, 43629.12741745163, 8436.114208008163, 8666.306695464347, 8676.956615216915, 8692.652293908237, 8728.956355218215, 8886.422382545146, 9001.009888912215, 9024.052474490183, 9038.593263303133, 9044.819103617923, 8903.821923561525, 8909.06454822244, 8914.821703565925, 8931.55342232889, 9005.099490051009, 8922.197002269795, 9028.50343231122, 9033.728988130333, 9060.54697265134, 9064.501452420114, 8804.823903521894, 8808.251298639623, 8908.420952638122, 8913.910860891372, 8914.598843052077, 40755.18489630191, 40933.1813363734, 41027.38458923119, 41090.0, 41307.58692413067, 3448.827558622059, 3482.37317282889, 3569.821508924543, 3588.982055089708, 4068.9796551017353, 31045.689543104505, 31058.689413105807, 31254.687453125633, 31328.530072048936, 32901.3419731604, 4353.673474489395, 4464.843730469418, 4492.281235002384, 4535.274356103041, 4549.24937385331, 226727.0, 230080.0, 231000.0, 231169.0, 231475.0, 59434.70282648559, 59632.80734385288, 60004.399955999885, 60194.0, 60198.39801602015, 62281.0, 62809.37190628035, 62824.68587657032, 62952.85235738195, 63182.0, 14730.926345368205, 14929.552113436614, 14941.477048303257, 14957.102573845386, 15006.549803505912, 11321.603743868925, 11528.308301501937, 11551.595694150665, 11555.942220289013, 11566.0, 17474.21366038506, 18148.0, 18174.18216180275, 18200.45398638043, 18225.362112326005, 5979.252593425822, 5998.220231369894, 6070.7875224366935, 6101.725422356005, 6138.6623735694075, 843.0726201178777, 859.2653281444275, 971.946542940145, 1100.4662738571785, 1166.9841964672128, 30713.385732285675, 30787.384252315278, 31216.687833121832, 31367.372652546823, 31426.685733142833, 965.4593427680521, 1070.4054731678727, 1103.4372470040337, 1140.1733743036232, 1154.936478493674, 15971.840281597268, 16146.434874779326, 16201.4329498467, 16209.108499032667, 16273.745250949858, 492697.0, 497509.0, 498859.0, 500900.0, 501008.0, 56968.0, 57049.429505705244, 57301.71349143311, 57390.139147912814, 57558.13662795061, 1253.7116463213513, 1305.575687901436, 1318.7955866840846, 1319.993400033013, 1322.4842311498523, 27966.3008424791, 29745.851270743507, 30013.849930750206, 30123.849380752956, 30531.0, 47962.760186198844, 48081.0, 48298.0, 48329.0, 48347.516524834304, 342452.0, 344134.0, 344155.0, 345519.0, 345738.0, 40221.59778402178, 40426.1914761709, 40479.17843697099, 41699.86852563842, 41819.37270940877, 44842.77578612086, 45137.32294015527, 45763.77118114521, 46468.07063858771, 46698.0, 38709.41935870908, 38751.806240969745, 39435.40846887356, 40014.39978400384, 40620.1875962485, 38520.0, 38715.80642096772, 38981.0, 39698.0, 39846.40230396488, 39068.804655976535, 39119.80440097781, 39662.0, 40394.79802600968, 42115.0, 30614.387712245185, 33413.0, 33733.49399759054, 33749.662503375635, 33845.66154338425, 27476.58785118185, 27607.723922761317, 27759.44481110326, 27951.720482795725, 28061.298467538476], "value": 19369.73446542043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.6629899389542, 383.995543264161, 391.3249644363473, 391.3620798099098, 418.144893692399, 16250.024998500068, 17132.657346853088, 17829.197686104126, 19408.805911940875, 19477.902610486926, 18838.152283147258, 19164.616707665875, 19226.807731922676, 19527.70708439371, 19776.11007504662, 5069.290299358084, 5088.287639730441, 5145.176771716526, 5200.92198617021, 5286.04851126797, 5127.487251274862, 5240.68555886648, 5243.973780131094, 5253.658512196714, 5256.42179360272, 5650.0959846424585, 5935.673537955432, 5955.868385006856, 5967.671778052206, 5970.34326224115, 5682.261306030189, 5824.679642619654, 5898.1447690084915, 5901.262342207224, 5938.435848594377, 5757.193992841006, 5761.625494342854, 5764.423557644244, 5764.884702305931, 5782.045962416196, 13456.394462249222, 13845.930770346184, 13887.166769993833, 14026.649333766636, 21946.46374753768, 2131.509752756859, 2251.5609456156058, 2266.478709896733, 2311.5608034473566, 2659.468106378732, 9232.676856309998, 10206.700354116105, 10337.276390652582, 14521.927390363086, 14621.707565848623, 1887.7923428422862, 1893.1007771308655, 1913.5252795092426, 1937.428458604715, 2020.8888511131881, 79147.6042619789, 82973.58513207456, 85007.5749621254, 85255.57372213161, 85857.57071214667, 10577.735556610993, 10591.0, 10903.127749779998, 10947.616833410952, 11018.50416731249, 15153.54539363821, 15161.924190379199, 15171.393144274105, 15187.772183417257, 15218.467353642569, 7145.857082858313, 7388.667509962064, 7516.661750221253, 7731.57124203697, 7998.280154786097, 7005.229424763272, 7134.507598085717, 7335.669894854745, 7353.117625884928, 7365.48441609093, 4568.680192386568, 4623.468301145344, 4627.699199552018, 4656.8137274508645, 4682.1338052460405, 1913.8373238274623, 1929.604431091623, 1963.891985940787, 2044.3866839947957, 2050.3336415664967, 828.7969447485405, 910.5356268303213, 950.3442624589012, 989.1098011789303, 989.7179303898355, 18754.1560629772, 19728.802711972698, 19827.900860495603, 19923.701144482846, 20042.198312067645, 957.7940742740205, 980.0836218136066, 984.9753756156153, 1018.2922868606396, 1020.7958408318218, 10306.278560500694, 11161.609343672932, 11164.330140191452, 11180.385078820744, 11192.0, 386355.0, 391911.0, 392562.0, 397097.0, 408754.0, 64847.0, 90411.54794225987, 91266.0, 91889.5405522968, 91961.5401922986, 939.6758118449261, 980.2794945714894, 1007.4005966449951, 1008.2841182760176, 1009.9293049486465, 16715.74926376081, 17154.142292885055, 17744.51576779226, 17779.555511112325, 17880.731789022913, 39314.410283845194, 39593.20813583655, 41643.58356416518, 42135.0, 42466.78766606147, 53158.46841531535, 53245.201321979424, 53553.73223134015, 54883.72558137184, 56009.439905600426, 7804.765857024298, 7998.400119990907, 8324.958375208085, 8404.831903361775, 8480.957595211985, 11119.332840029625, 11998.0, 12243.32661703615, 12370.13409061357, 12437.813432798695, 9594.18449431806, 10146.49267536635, 10959.780804383709, 11225.775484490428, 11695.824562631737, 10701.518431670438, 10790.784184316426, 10854.511546980562, 10887.782244355227, 11079.61221357281, 10735.248532602644, 10826.0, 10850.29473084247, 10972.506237219504, 11273.71815704614, 6994.33553812387, 7880.645370958206, 7901.4987152443155, 8101.918980810352, 8123.4313598047565, 10419.42693151884, 10811.459427028774, 10903.182261330274, 10973.0, 11451.0], "value": 8835.120686422546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.3336865095037, 1519.9392024319027, 1685.3595633659208, 1785.1966615023243, 1803.9188236529355, 8150.3887208459455, 8172.795680107993, 8412.747617571467, 8728.170823771747, 8820.382573219877, 8761.912380876189, 9127.908720912788, 9131.543422828849, 9275.30435217358, 9433.433993960367, 2273.12484693393, 2332.8716920569364, 2362.633791762271, 2365.396823809926, 2369.052379048377, 2298.19563152896, 2307.157887371114, 2348.6829278047503, 2360.4570948681812, 2371.490129622131, 2278.4759505313787, 2287.2795069553035, 2299.793018628323, 2331.708536432946, 2342.309018839438, 2279.763998355315, 2281.258590957929, 2283.4519715268384, 2286.0741399733133, 2298.5058212484314, 2282.1213832674375, 2290.5647926894003, 2293.7591552886875, 2295.8048565871923, 2297.287840769367, 9253.583588738524, 9298.488583127924, 9362.157405833508, 9368.718938431857, 9414.670486533007, 5289.894202115975, 5397.0, 5424.674519528801, 5447.727613619303, 5463.590230732671, 3269.215388306813, 3300.1089705779546, 3453.1367158210446, 3461.0, 3495.94756078659, 1036.7874585709912, 1038.3717850700293, 1053.1311667874033, 1056.1234175634281, 1073.2755390111722, 13020.674483137902, 13043.217406955519, 13172.341382930816, 13173.275469849155, 13213.603591892163, 4421.098927461158, 4627.213373726475, 4667.509911459316, 4712.434507859079, 4714.127886341038, 10912.0, 10919.727006824734, 10958.780824383468, 10971.561137554569, 11043.0, 5439.9936011837935, 5440.0, 5444.5916556258435, 5452.945470545244, 5458.4814442627885, 4356.607905288539, 4493.932591011137, 4716.245400735866, 4856.95143048565, 5011.022850544182, 3884.4561761353434, 3991.660708839723, 4028.2547728669706, 4094.6928980326593, 4101.282275601758, 1244.520859469111, 1263.387257180267, 1268.3911722373311, 1273.9554115605908, 1281.814136950137, 935.1910597333258, 979.1187930862138, 986.7779749556292, 990.2226751999646, 995.9402435853872, 5986.910196347058, 5987.221661184019, 6155.138280640714, 6172.598781079216, 6198.597091189058, 434.9478062632441, 439.48141193392104, 439.9890002749893, 979.2900147393225, 992.2409356842022, 4084.9795751021056, 4195.496540415109, 4233.5131459882505, 4236.894077648022, 4258.914821703549, 11183.776324473465, 11591.188616796744, 11635.301881887113, 11641.76716465666, 11679.649610511698, 11449.942750286194, 11471.426428678533, 11485.540578376938, 11514.596989105508, 11539.71150721222, 8504.362172836938, 8565.357598180162, 8706.477611343213, 8707.564621768886, 8737.737867863974, 6065.484433822998, 6187.0, 6193.102000209854, 6211.596246243979, 6240.968795155995, 10570.682879513626, 10628.734281642712, 10722.088622467178, 10740.73148171302, 10798.946005269923, 10498.740151181906, 10670.46647667629, 10852.511636976196, 10908.454577271263, 11076.889231107585, 6967.930320696728, 7177.964110179416, 7477.40180785525, 7649.120351159465, 7697.846043079219, 8753.431026983226, 9056.094390560891, 9084.40951338161, 9087.954560227157, 9103.317251206054, 7832.099308579586, 7907.090684571348, 7978.640961156646, 8071.394645401501, 8197.836043278981, 7955.0, 8047.436679432383, 8096.230858068474, 8160.183981601793, 8263.091059983277, 7407.296306850841, 7437.851242975218, 7465.06686664167, 7534.171241163577, 7539.1706912238515, 5196.870078248074, 5369.919451208157, 5411.945880541144, 5419.0, 5586.636868603528, 5306.575473962151, 5313.946860531345, 5336.946630533645, 5369.0, 5443.918341224806], "value": 4708.254978510919, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9245773472101, 332.7388000419671, 338.2119661189429, 340.3618215845289, 345.1939720752044, 5325.866853328659, 5469.535089517386, 5495.587830912677, 5575.804846830361, 5625.887482250358, 5239.973800131003, 5364.651297665649, 5440.564754819605, 5455.645383050099, 5466.590005749565, 4305.45977873054, 4317.222899878021, 4317.352397140438, 4321.524632290446, 4323.113761678848, 4181.981865478259, 4230.4500414946015, 4311.353297005443, 4327.783610819446, 4329.731053054955, 4273.230818452677, 4278.0, 4281.828726850922, 4292.957070429303, 4300.806463709125, 4280.122574872159, 4301.0, 4317.719348242385, 4322.876052226444, 4337.0, 3720.251481803548, 3855.8072096395067, 3859.2667393195484, 3864.478295430109, 3870.3420418528917, 5322.866928326784, 5326.174442961347, 5337.092694241988, 5343.412224655285, 5350.5184533392185, 4876.293297345936, 4886.631743111934, 4902.632302577321, 4905.068037072945, 4905.3623029006, 5497.752601132958, 5636.633618814764, 5657.708628005665, 5738.540916726652, 5754.510866576346, 4142.91714165715, 4143.6685065195015, 4156.501219853637, 4182.832686692559, 4192.81132349045, 5990.8502287442725, 6022.488088512482, 6027.186329845503, 6048.395160483917, 6056.485878530368, 3957.3074711925296, 4203.43253660758, 4318.784060796947, 4319.438472998553, 4320.870373888788, 4179.937300940488, 4221.978890105591, 4231.8730438086295, 4239.745615263094, 4242.618164365222, 4887.340209071801, 4889.266610008527, 4922.458529561745, 4923.507649235048, 4937.23472861707, 5615.410381909923, 5694.145878118233, 5855.130985817004, 5886.764529418861, 5893.263342082239, 1467.8311994120813, 1504.706582216479, 1509.4943194029904, 1515.6892836968395, 1517.446132161753, 916.3127654259306, 951.4338968313842, 953.270747877874, 965.1747755668943, 967.862761255522, 4841.975790121027, 4866.513348665105, 4881.658283920092, 4890.682105663192, 4924.901501969941, 5129.487051294916, 5192.402873669576, 5213.895722085537, 5221.921671174935, 5282.207668849626, 4785.545373189541, 4913.557779799764, 4939.56752541766, 4967.0, 5000.3249561309485, 2752.2844060544403, 2758.2828464598947, 2761.8619069046467, 2766.7233276672573, 2772.5979732938613, 5307.6284660073425, 5351.983123206656, 5365.0, 5393.867287869512, 5419.783208671688, 4873.366462359871, 5256.684598924076, 5268.578513718893, 5326.6005049621435, 5346.946530534723, 5271.947280527223, 5280.653433374465, 5287.656302340336, 5301.337332833319, 5328.520433161034, 5143.819966301311, 5148.970205958748, 5195.765820696985, 5200.401953775364, 5228.947710522846, 5113.539781419541, 5427.728613569385, 5795.449432303924, 5894.70526473666, 5941.673207973603, 6215.285242197205, 6229.414792861093, 6274.403931626488, 6280.842978925563, 6296.811095667137, 3973.6225058619384, 4217.409562661292, 4226.4083028375435, 4236.195122926634, 4247.830086796494, 5717.313922329347, 5893.3204036851, 5906.468417842415, 5924.526037917042, 5942.910856337072, 5802.245708057925, 5818.912716309174, 5842.883142337215, 5845.473907348359, 5954.37479064692, 5827.271591051119, 5835.854103647443, 5836.328822185503, 5847.473727364558, 5867.970660146672, 5587.385387607441, 5739.942600574108, 5769.701817091121, 5779.2775903012125, 5787.247657804627, 5791.333996590446, 5792.333881603669, 5833.358330583717, 5878.559108066997, 5898.08045017719, 5183.667349692578, 5524.790083966445, 5639.154126881001, 5655.886882262414, 5693.3168019837885], "value": 4274.222086895488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.9116360454943, 736.0357931110243, 741.7848823841085, 771.3944553525483, 849.4351256414483, 15450.845491545082, 16244.918775406106, 16660.333586656518, 16786.91606541967, 17310.394136205236, 14465.481124481936, 14712.779308310384, 14759.631009224775, 14765.335559899804, 14782.0, 799.7680672604938, 816.6243527977138, 820.7127505373102, 821.1008945204991, 821.2485575698229, 793.0800271684847, 818.8526065308242, 819.5410570080744, 822.3298012120133, 823.3742355809597, 864.8313578852126, 864.9005364383114, 865.7705707987388, 869.1178453869328, 871.4161511787117, 860.475110182788, 861.3582880753847, 864.7535452396099, 865.4071960706905, 865.6926790989171, 628.8868003759321, 632.3771085480797, 632.5129650169343, 632.7279269913935, 635.0220660183312, 15976.121313327762, 15986.12076335801, 16003.919980400024, 16030.35878564856, 16048.75926861098, 14778.0, 14803.18582477974, 14888.34489188478, 15032.624184395369, 15104.848951510565, 11846.268425445956, 11879.22785018971, 11897.762044759056, 12021.338826364547, 12651.873481265253, 3692.576610039868, 3840.6543411092857, 3849.8267577958777, 3913.25648126855, 3973.284808734427, 77774.61112694457, 79639.6018019912, 79735.60132199302, 80119.0, 81024.59487702524, 10914.0, 11075.50160242791, 11090.279131856403, 11221.438928053565, 11568.132390070778, 20590.382288531368, 20612.072456739483, 20614.381568552668, 20717.0677319521, 20722.171113155608, 7850.450468467267, 7913.287804097658, 7958.442908996431, 8207.425480216327, 8244.917550824535, 4834.827398345784, 4835.0571638530855, 4909.091818013679, 5001.999600079998, 5002.074616196015, 3630.582483014487, 3749.5875453700073, 3757.530308711411, 3767.547894252707, 3776.5090538229856, 641.6695401868042, 658.9785831960443, 659.0378048049805, 666.9933300666931, 671.835400326923, 616.8827922694674, 631.8104568629393, 659.5317324699421, 664.3489380407228, 733.6258508160877, 8923.0, 9275.211607013345, 9502.619895204252, 9617.374870633526, 9747.853782193273, 647.8283254937445, 657.8322527755391, 687.5049964025893, 700.1493185779302, 739.6597565119997, 4356.912861742748, 4778.283257511401, 4873.463918968911, 4893.7063776173545, 5046.59627229828, 59510.0, 60754.0, 107226.46386768016, 112223.21656226143, 114859.0, 93431.0, 96033.51983240039, 99068.0, 99704.0, 100252.0, 77955.0, 86668.0, 87798.56100719456, 87853.12146878577, 87906.56046719853, 9307.177797743998, 9343.439393636403, 9733.80532389334, 9744.902550974683, 9783.902160978583, 48005.27992080191, 48255.75872120617, 49779.502204977485, 49804.0, 50806.491935081656, 43459.34810977775, 44062.11875762531, 68229.0, 71126.15495380126, 74672.42577400511, 11540.769184616092, 11850.348230847387, 11890.464929078385, 12192.87807121953, 12596.748065038832, 13401.396937138048, 13442.395092220679, 13506.122102063335, 13839.792403113759, 14221.14673119616, 10812.729681758019, 11050.668479945614, 11181.552737890393, 11440.656780296604, 11589.768204635691, 11710.0, 12178.939105304771, 12758.298293593942, 12775.425105870445, 12806.743865122831, 12609.621711348675, 12726.490940362652, 13036.739265214832, 13079.476820927057, 13538.79691804604, 9294.442333460014, 9327.253819694273, 9830.606775728891, 9963.153131983572, 10118.038786315288, 10070.345427547187, 10546.894531054591, 10637.202209834139, 10650.520726567169, 10745.94627026891], "value": 7355.502374159404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 123.0, 129.0, 170.0, 125.0, 126.0, 126.0, 123.0, 154.0, 125.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 167.0, 167.0, 163.0, 161.0, 162.0, 163.0, 162.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 106.0, 75.0, 76.0, 77.0, 77.0, 110.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 105.0, 84.0, 83.0, 82.0, 103.0, 82.0, 84.0, 104.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 120.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 149.0, 149.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 86.0, 84.0, 86.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 54.0, 54.0, 66.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 60.0, 59.0, 60.0, 61.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 81.0, 80.0, 82.0, 90.0, 82.0, 81.0, 79.0, 82.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 130.0, 137.0, 131.0, 131.0, 137.0, 142.0, 132.0, 169.0, 130.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 167.0, 169.0, 166.0, 168.0, 168.0, 164.0, 167.0, 166.0, 167.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 65.0, 66.0, 71.0, 66.0, 78.0, 65.0, 65.0], "value": 67.9, "unit": "score"}]}]} 22:51:22 INFO - Return code: 0 22:51:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:51:22 ERROR - # TBPL SUCCESS # 22:51:22 INFO - Running post-action listener: _resource_record_post_action 22:51:22 INFO - [mozharness: 2016-10-24 05:51:22.455181Z] Finished run-tests step (success) 22:51:22 INFO - Running post-run listener: _resource_record_post_run 22:51:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 391376896; Read time: 0; Write time: 323456 22:51:22 INFO - TinderboxPrint: CPU usage
13.5% 22:51:22 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 22:51:22 INFO - TinderboxPrint: I/O write bytes / time
391,376,896 / 323,456 22:51:22 INFO - TinderboxPrint: CPU idle
8,252.9 (86.5%) 22:51:22 INFO - TinderboxPrint: CPU user
1,221.7 (12.8%) 22:51:22 INFO - TinderboxPrint: Swap in / out
0 / 0 22:51:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103555072; Read time: 0; Write time: 126584 22:51:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287465472; Read time: 0; Write time: 196824 22:51:23 INFO - Running post-run listener: _upload_blobber_files 22:51:23 INFO - Blob upload gear active. 22:51:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:51:23 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 22:51:23 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:51:23 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:51:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:51:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:51:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:24 INFO - (blobuploader) - INFO - Done attempting. 22:51:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:51:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:28 INFO - (blobuploader) - INFO - Done attempting. 22:51:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:51:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:51:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:51:28 INFO - (blobuploader) - INFO - Done attempting. 22:51:28 INFO - (blobuploader) - INFO - Iteration through files over. 22:51:28 INFO - Return code: 0 22:51:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:51:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:51:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1ba58c813a69bed312913bc78afc193cff9b19a46a687fe6ad24045daf948bade84c183e2a706b6ef960ace3b9f65d18dbeb2a788dd6af553b0ddc9fff38f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc9725f587178d7ec39d6d19944234fc96fbaf95173ce88aaa0a14785f7d8c52c11a100e5e08f26f42592f37271639048df59fafbc3408e5cbbacbedf453383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36a3a6984492e139858ebfc42dce4ddb2258d19dd3a22cebf5ef4b96dbbdbd52b4e4f291b7a99c9f646e9081d5f198f4270ab5b43d764491072cddb1782292"} 22:51:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:51:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:51:28 INFO - Contents: 22:51:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1ba58c813a69bed312913bc78afc193cff9b19a46a687fe6ad24045daf948bade84c183e2a706b6ef960ace3b9f65d18dbeb2a788dd6af553b0ddc9fff38f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc9725f587178d7ec39d6d19944234fc96fbaf95173ce88aaa0a14785f7d8c52c11a100e5e08f26f42592f37271639048df59fafbc3408e5cbbacbedf453383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36a3a6984492e139858ebfc42dce4ddb2258d19dd3a22cebf5ef4b96dbbdbd52b4e4f291b7a99c9f646e9081d5f198f4270ab5b43d764491072cddb1782292"} 22:51:28 INFO - Running post-run listener: copy_logs_to_upload_dir 22:51:28 INFO - Copying logs to upload dir... 22:51:28 INFO - mkdir: /builds/slave/test/build/upload/logs 22:51:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.933789 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-10-23 22:51:28.253536) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 22:51:28.256837) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 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/Firefox/sha512/a1ba58c813a69bed312913bc78afc193cff9b19a46a687fe6ad24045daf948bade84c183e2a706b6ef960ace3b9f65d18dbeb2a788dd6af553b0ddc9fff38f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc9725f587178d7ec39d6d19944234fc96fbaf95173ce88aaa0a14785f7d8c52c11a100e5e08f26f42592f37271639048df59fafbc3408e5cbbacbedf453383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36a3a6984492e139858ebfc42dce4ddb2258d19dd3a22cebf5ef4b96dbbdbd52b4e4f291b7a99c9f646e9081d5f198f4270ab5b43d764491072cddb1782292"} build_url:https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/OZFt94NOSLC3OVSSMb7TOg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1ba58c813a69bed312913bc78afc193cff9b19a46a687fe6ad24045daf948bade84c183e2a706b6ef960ace3b9f65d18dbeb2a788dd6af553b0ddc9fff38f8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc9725f587178d7ec39d6d19944234fc96fbaf95173ce88aaa0a14785f7d8c52c11a100e5e08f26f42592f37271639048df59fafbc3408e5cbbacbedf453383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f36a3a6984492e139858ebfc42dce4ddb2258d19dd3a22cebf5ef4b96dbbdbd52b4e4f291b7a99c9f646e9081d5f198f4270ab5b43d764491072cddb1782292"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 22:51:28.283375) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:51:28.283736) ========= 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=a0d2d2de893abaa8702a9954000001a7-1477284029.726632-1430907275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 22:51:28.368585) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 22:51:28.369031) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 22:51:28.369378) ========= ========= Total master_lag: 0.18 =========