builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1476051658.91 results: success (0) buildid: 20161009123001 builduid: 43249cd6610549e4a97a291682fe54e8 revision: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:58.906441) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:58.906915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:58.907237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:58.938233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:58.938545) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-09 15:20:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-10-09 15:20:59 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:59.118397) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:59.118808) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013815 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:20:59.171545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 15:20:59.172281) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 --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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-09 15:20:59,692 truncating revision to first 12 chars 2016-10-09 15:20:59,692 Setting DEBUG logging. 2016-10-09 15:20:59,692 attempt 1/10 2016-10-09 15:20:59,692 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d72cf6ecebaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-09 15:21:00,544 unpacking tar archive at: fx-team-d72cf6ecebaf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.183111 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-09 15:21:00.371013) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 15:21:00.371391) ========= script_repo_revision: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-09 15:21:00.371903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 15:21:00.372217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-09 15:21:00.381827) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-09 15:21:00.382136) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:21:00 INFO - MultiFileLogger online at 20161009 15:21:00 in /builds/slave/test 15:21:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:21:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:21:00 INFO - {'append_to_log': False, 15:21:00 INFO - 'base_work_dir': '/builds/slave/test', 15:21:00 INFO - 'blob_upload_branch': 'Fx-Team', 15:21:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:21:00 INFO - 'branch': 'Fx-Team', 15:21:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:21:00 INFO - 'config_files': ('talos/linux_config.py',), 15:21:00 INFO - 'default_actions': ('clobber', 15:21:00 INFO - 'read-buildbot-config', 15:21:00 INFO - 'download-and-extract', 15:21:00 INFO - 'populate-webroot', 15:21:00 INFO - 'create-virtualenv', 15:21:00 INFO - 'install', 15:21:00 INFO - 'run-tests'), 15:21:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:21:00 INFO - 'download_minidump_stackwalk': True, 15:21:00 INFO - 'download_symbols': 'ondemand', 15:21:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:21:00 INFO - 'tooltool.py': '/tools/tooltool.py', 15:21:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:21:00 INFO - '/tools/misc-python/virtualenv.py')}, 15:21:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:21:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:21:00 INFO - 'installer_path': 'installer.exe', 15:21:00 INFO - 'log_level': 'info', 15:21:00 INFO - 'log_name': 'talos', 15:21:00 INFO - 'log_to_console': True, 15:21:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:21:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:21:00 INFO - 'opt_config_files': (), 15:21:00 INFO - 'pip_index': False, 15:21:00 INFO - 'sps_profile': False, 15:21:00 INFO - 'sps_profile_interval': 0, 15:21:00 INFO - 'suite': 'dromaeojs', 15:21:00 INFO - 'system_bits': '32', 15:21:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:21:00 INFO - 'title': 'talos-linux64-ix-066', 15:21:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:21:00 INFO - 'use_talos_json': True, 15:21:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:21:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:21:00 INFO - 'work_dir': 'build'} 15:21:00 INFO - [mozharness: 2016-10-09 22:21:00.997903Z] Running clobber step. 15:21:00 INFO - Running pre-action listener: _resource_record_pre_action 15:21:00 INFO - Running main action method: clobber 15:21:00 INFO - rmtree: /builds/slave/test/build 15:21:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:21:01 INFO - Running post-action listener: _resource_record_post_action 15:21:01 INFO - [mozharness: 2016-10-09 22:21:01.963690Z] Finished clobber step (success) 15:21:01 INFO - [mozharness: 2016-10-09 22:21:01.963792Z] Running read-buildbot-config step. 15:21:01 INFO - Running pre-action listener: _resource_record_pre_action 15:21:01 INFO - Running main action method: read_buildbot_config 15:21:01 INFO - Using buildbot properties: 15:21:01 INFO - { 15:21:01 INFO - "project": "", 15:21:01 INFO - "product": "firefox", 15:21:01 INFO - "script_repo_revision": "production", 15:21:01 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 15:21:01 INFO - "repository": "", 15:21:01 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 15:21:01 INFO - "buildid": "20161009123001", 15:21:01 INFO - "pgo_build": "True", 15:21:01 INFO - "basedir": "/builds/slave/test", 15:21:01 INFO - "buildnumber": 520, 15:21:01 INFO - "slavename": "talos-linux64-ix-066", 15:21:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:21:01 INFO - "platform": "ubuntu64_hw", 15:21:01 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 15:21:01 INFO - "branch": "fx-team", 15:21:01 INFO - "repo_path": "integration/fx-team", 15:21:01 INFO - "revision": "d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1", 15:21:01 INFO - "stage_platform": "linux64-pgo", 15:21:01 INFO - "builduid": "43249cd6610549e4a97a291682fe54e8", 15:21:01 INFO - "slavebuilddir": "test" 15:21:01 INFO - } 15:21:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:21:01 INFO - Running post-action listener: _resource_record_post_action 15:21:01 INFO - [mozharness: 2016-10-09 22:21:01.966241Z] Finished read-buildbot-config step (success) 15:21:01 INFO - [mozharness: 2016-10-09 22:21:01.966329Z] Running download-and-extract step. 15:21:01 INFO - Running pre-action listener: _resource_record_pre_action 15:21:01 INFO - Running main action method: download_and_extract 15:21:01 INFO - mkdir: /builds/slave/test/build/tests 15:21:01 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')]} 15:21:01 INFO - trying https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:21:01 INFO - Downloading https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/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 15:21:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/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 15:21:02 INFO - Downloaded 1361 bytes. 15:21:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:21:02 INFO - Using the following test package requirements: 15:21:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:21:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:21:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'jsshell-linux-x86_64.zip'], 15:21:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:21:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:21:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:21:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:21:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:21:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:21:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:21:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:21:03 INFO - Http code: 200 15:21:03 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:21:03 INFO - x-amz-cf-id: 6q29w4rpiY9oRSToYPwM2aWUCC-YO5we2i-ElHmlzfMCYKvAjGU8LA== 15:21:03 INFO - x-amz-version-id: zDywj18O3QAVlGlnWQA11IPflfXGGhR2 15:21:03 INFO - Expected file size: 22088635 15:21:03 INFO - Obtained file size: 22088635 15:21:07 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 15:21:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:21:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:21:07 INFO - Fetch https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:21:08 INFO - Http code: 200 15:21:08 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 15:21:08 INFO - x-amz-cf-id: 8RgLIVPhKxwaBIyrB9DDZgQdgHyNSG-q0cn_0VF0uZB6xfigiGjKuA== 15:21:08 INFO - x-amz-version-id: zDywj18O3QAVlGlnWQA11IPflfXGGhR2 15:21:08 INFO - Expected file size: 22088635 15:21:08 INFO - Obtained file size: 22088635 15:21:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:21:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:21:12 INFO - Fetch https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:21:13 INFO - Http code: 200 15:21:13 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 15:21:13 INFO - x-amz-cf-id: q4Z_6snkkmW7SKXrcUKV0sgsOO7nkDH4WfeEZG8xeOEAgotJXObuXQ== 15:21:13 INFO - x-amz-version-id: qV51Npdu6VI6C128WNNqRWQP5kV1BncY 15:21:13 INFO - Expected file size: 14409006 15:21:13 INFO - Obtained file size: 14409006 15:21:13 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')]} 15:21:13 INFO - trying https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:21:13 INFO - Downloading https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/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 15:21:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/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 15:21:15 INFO - Downloaded 59728643 bytes. 15:21:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:21:15 INFO - mkdir: /builds/slave/test/properties 15:21:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:21:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:21:15 INFO - Contents: 15:21:15 INFO - build_url:https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:21:15 INFO - Running post-action listener: _resource_record_post_action 15:21:15 INFO - Running post-action listener: set_extra_try_arguments 15:21:15 INFO - [mozharness: 2016-10-09 22:21:15.712167Z] Finished download-and-extract step (success) 15:21:15 INFO - [mozharness: 2016-10-09 22:21:15.712392Z] Running populate-webroot step. 15:21:15 INFO - Running pre-action listener: _resource_record_pre_action 15:21:15 INFO - Running main action method: populate_webroot 15:21:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:21:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:21:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:21:15 INFO - '--tppagecycles', 15:21:15 INFO - '7'], 15:21:15 INFO - 'tests': ['tsvgm']}}, 15:21:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:21:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:21:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:21:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:21:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:21:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['damp', 'tps']}, 15:21:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'tests': ['damp', 'tps']}, 15:21:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['dromaeo_dom']}, 15:21:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:21:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['basic_compositor_video']}, 15:21:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:21:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'other-e10s': {'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['a11yr', 15:21:15 INFO - 'ts_paint', 15:21:15 INFO - 'tpaint', 15:21:15 INFO - 'sessionrestore', 15:21:15 INFO - 'sessionrestore_no_auto_restore', 15:21:15 INFO - 'tabpaint']}, 15:21:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['tsvgx', 15:21:15 INFO - 'tsvgr_opacity', 15:21:15 INFO - 'tart', 15:21:15 INFO - 'tscrollx', 15:21:15 INFO - 'cart']}, 15:21:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:21:15 INFO - 'tsvgr_opacity', 15:21:15 INFO - 'tart', 15:21:15 INFO - 'tscrollx', 15:21:15 INFO - 'cart']}, 15:21:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'talos_options': ['--disable-e10s'], 15:21:15 INFO - 'tests': ['tp5o']}, 15:21:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'tests': ['tp5o']}, 15:21:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'talos_options': ['--disable-e10s', 15:21:15 INFO - '--xperf_path', 15:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:15 INFO - 'tests': ['tp5n']}, 15:21:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:21:15 INFO - 'talos_options': ['--xperf_path', 15:21:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:21:15 INFO - 'tests': ['tp5n']}}, 15:21:15 INFO - 'talos.zip': {'path': '', 15:21:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:21:15 INFO - Running post-action listener: _resource_record_post_action 15:21:15 INFO - [mozharness: 2016-10-09 22:21:15.729281Z] Finished populate-webroot step (success) 15:21:15 INFO - [mozharness: 2016-10-09 22:21:15.729369Z] Running create-virtualenv step. 15:21:15 INFO - Running pre-action listener: _resource_record_pre_action 15:21:15 INFO - Running main action method: create_virtualenv 15:21:15 INFO - Creating virtualenv /builds/slave/test/build/venv 15:21:15 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 15:21:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:21:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:21:15 INFO - Using real prefix '/usr' 15:21:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:21:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:21:18 INFO - Installing pip.................done. 15:21:18 INFO - Return code: 0 15:21:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:21:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:21:18 INFO - Reading from file tmpfile_stdout 15:21:18 INFO - Output received: 15:21:18 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) 15:21:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:21:18 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')]} 15:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:18 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')]} 15:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:18 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:18 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 15:21:18 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 15:21:18 INFO - Using env: {'DISPLAY': ':0', 15:21:18 INFO - 'HOME': '/home/cltbld', 15:21:18 INFO - 'LANG': 'en_US.UTF-8', 15:21:18 INFO - 'LANGUAGE': 'en_US:en', 15:21:18 INFO - 'LOGNAME': 'cltbld', 15:21:18 INFO - 'MAIL': '/var/mail/cltbld', 15:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:18 INFO - 'MOZ_NO_REMOTE': '1', 15:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:18 INFO - 'NO_EM_RESTART': '1', 15:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:18 INFO - 'PWD': '/builds/slave/test', 15:21:18 INFO - 'SHELL': '/bin/bash', 15:21:18 INFO - 'SHLVL': '1', 15:21:18 INFO - 'TERM': 'linux', 15:21:18 INFO - 'TMOUT': '86400', 15:21:18 INFO - 'USER': 'cltbld', 15:21:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:18 INFO - '_': '/tools/buildbot/bin/python'} 15:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:18 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 15:21:18 INFO - Cleaning up... 15:21:18 INFO - Return code: 0 15:21:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:21:18 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')]} 15:21:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:18 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')]} 15:21:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:18 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:18 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 15:21:18 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 15:21:18 INFO - Using env: {'DISPLAY': ':0', 15:21:18 INFO - 'HOME': '/home/cltbld', 15:21:18 INFO - 'LANG': 'en_US.UTF-8', 15:21:18 INFO - 'LANGUAGE': 'en_US:en', 15:21:18 INFO - 'LOGNAME': 'cltbld', 15:21:18 INFO - 'MAIL': '/var/mail/cltbld', 15:21:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:18 INFO - 'MOZ_NO_REMOTE': '1', 15:21:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:18 INFO - 'NO_EM_RESTART': '1', 15:21:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:18 INFO - 'PWD': '/builds/slave/test', 15:21:18 INFO - 'SHELL': '/bin/bash', 15:21:18 INFO - 'SHLVL': '1', 15:21:18 INFO - 'TERM': 'linux', 15:21:18 INFO - 'TMOUT': '86400', 15:21:18 INFO - 'USER': 'cltbld', 15:21:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:18 INFO - '_': '/tools/buildbot/bin/python'} 15:21:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:18 INFO - Downloading/unpacking psutil>=3.1.1 15:21:18 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 15:21:18 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 15:21:18 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 15:21:18 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 15:21:18 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 15:21:18 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 15:21:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:21:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:20 INFO - Installing collected packages: psutil 15:21:20 INFO - Running setup.py install for psutil 15:21:21 INFO - building 'psutil._psutil_linux' extension 15:21:21 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 15:21:21 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 15:21:21 INFO - building 'psutil._psutil_posix' extension 15:21:21 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 15:21:21 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 15:21:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:21:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:21:21 INFO - Successfully installed psutil 15:21:21 INFO - Cleaning up... 15:21:21 INFO - Return code: 0 15:21:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:21: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')]} 15:21:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21: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')]} 15:21:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:21 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:21 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 15:21:21 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 15:21:21 INFO - Using env: {'DISPLAY': ':0', 15:21:21 INFO - 'HOME': '/home/cltbld', 15:21:21 INFO - 'LANG': 'en_US.UTF-8', 15:21:21 INFO - 'LANGUAGE': 'en_US:en', 15:21:21 INFO - 'LOGNAME': 'cltbld', 15:21:21 INFO - 'MAIL': '/var/mail/cltbld', 15:21:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:21 INFO - 'MOZ_NO_REMOTE': '1', 15:21:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:21 INFO - 'NO_EM_RESTART': '1', 15:21:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:21 INFO - 'PWD': '/builds/slave/test', 15:21:21 INFO - 'SHELL': '/bin/bash', 15:21:21 INFO - 'SHLVL': '1', 15:21:21 INFO - 'TERM': 'linux', 15:21:21 INFO - 'TMOUT': '86400', 15:21:21 INFO - 'USER': 'cltbld', 15:21:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:21 INFO - '_': '/tools/buildbot/bin/python'} 15:21:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:21:21 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 15:21:21 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 15:21:21 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 15:21:21 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 15:21:21 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 15:21:21 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 15:21:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:21:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:21:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:21:23 INFO - Installing collected packages: mozsystemmonitor 15:21:23 INFO - Running setup.py install for mozsystemmonitor 15:21:23 INFO - Successfully installed mozsystemmonitor 15:21:23 INFO - Cleaning up... 15:21:23 INFO - Return code: 0 15:21:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:21:23 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')]} 15:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:23 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')]} 15:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:23 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:23 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 15:21:23 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 15:21:23 INFO - Using env: {'DISPLAY': ':0', 15:21:23 INFO - 'HOME': '/home/cltbld', 15:21:23 INFO - 'LANG': 'en_US.UTF-8', 15:21:23 INFO - 'LANGUAGE': 'en_US:en', 15:21:23 INFO - 'LOGNAME': 'cltbld', 15:21:23 INFO - 'MAIL': '/var/mail/cltbld', 15:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:23 INFO - 'MOZ_NO_REMOTE': '1', 15:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:23 INFO - 'NO_EM_RESTART': '1', 15:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:23 INFO - 'PWD': '/builds/slave/test', 15:21:23 INFO - 'SHELL': '/bin/bash', 15:21:23 INFO - 'SHLVL': '1', 15:21:23 INFO - 'TERM': 'linux', 15:21:23 INFO - 'TMOUT': '86400', 15:21:23 INFO - 'USER': 'cltbld', 15:21:23 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:23 INFO - '_': '/tools/buildbot/bin/python'} 15:21:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:21:24 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 15:21:24 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 15:21:24 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 15:21:24 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 15:21:24 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 15:21:24 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 15:21:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:21:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:21:25 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 15:21:25 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 15:21:25 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 15:21:25 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 15:21:25 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 15:21:25 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 15:21:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:21:26 INFO - warning: no files found matching '*.txt' 15:21:26 INFO - no previously-included directories found matching 'build' 15:21:26 INFO - no previously-included directories found matching 'dist' 15:21:26 INFO - no previously-included directories found matching '.git*' 15:21:26 INFO - Installing collected packages: jsonschema, functools32 15:21:26 INFO - Running setup.py install for functools32 15:21:26 INFO - warning: no files found matching '*.txt' 15:21:26 INFO - no previously-included directories found matching 'build' 15:21:26 INFO - no previously-included directories found matching 'dist' 15:21:26 INFO - no previously-included directories found matching '.git*' 15:21:26 INFO - Successfully installed jsonschema functools32 15:21:26 INFO - Cleaning up... 15:21:26 INFO - Return code: 0 15:21:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:21:26 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')]} 15:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:26 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')]} 15:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:26 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:26 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 15:21:26 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 15:21:26 INFO - Using env: {'DISPLAY': ':0', 15:21:26 INFO - 'HOME': '/home/cltbld', 15:21:26 INFO - 'LANG': 'en_US.UTF-8', 15:21:26 INFO - 'LANGUAGE': 'en_US:en', 15:21:26 INFO - 'LOGNAME': 'cltbld', 15:21:26 INFO - 'MAIL': '/var/mail/cltbld', 15:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:26 INFO - 'MOZ_NO_REMOTE': '1', 15:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:26 INFO - 'NO_EM_RESTART': '1', 15:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:26 INFO - 'PWD': '/builds/slave/test', 15:21:26 INFO - 'SHELL': '/bin/bash', 15:21:26 INFO - 'SHLVL': '1', 15:21:26 INFO - 'TERM': 'linux', 15:21:26 INFO - 'TMOUT': '86400', 15:21:26 INFO - 'USER': 'cltbld', 15:21:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:26 INFO - '_': '/tools/buildbot/bin/python'} 15:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:21:26 INFO - Cleaning up... 15:21:26 INFO - Return code: 0 15:21:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:21:26 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')]} 15:21:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:26 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')]} 15:21:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:26 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:26 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 15:21:26 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 15:21:26 INFO - Using env: {'DISPLAY': ':0', 15:21:26 INFO - 'HOME': '/home/cltbld', 15:21:26 INFO - 'LANG': 'en_US.UTF-8', 15:21:26 INFO - 'LANGUAGE': 'en_US:en', 15:21:26 INFO - 'LOGNAME': 'cltbld', 15:21:26 INFO - 'MAIL': '/var/mail/cltbld', 15:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:26 INFO - 'MOZ_NO_REMOTE': '1', 15:21:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:26 INFO - 'NO_EM_RESTART': '1', 15:21:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:26 INFO - 'PWD': '/builds/slave/test', 15:21:26 INFO - 'SHELL': '/bin/bash', 15:21:26 INFO - 'SHLVL': '1', 15:21:26 INFO - 'TERM': 'linux', 15:21:26 INFO - 'TMOUT': '86400', 15:21:26 INFO - 'USER': 'cltbld', 15:21:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:26 INFO - '_': '/tools/buildbot/bin/python'} 15:21:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:26 INFO - Downloading/unpacking blobuploader==1.2.4 15:21:26 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 15:21:26 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 15:21:26 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 15:21:26 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 15:21:26 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 15:21:26 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 15:21:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:21:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:21:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:21:28 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 15:21:28 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 15:21:28 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 15:21:28 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 15:21:28 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 15:21:28 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 15:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:21:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:21:29 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 15:21:29 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 15:21:29 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 15:21:29 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 15:21:29 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 15:21:29 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 15:21:29 INFO - Downloading docopt-0.6.1.tar.gz 15:21:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:21:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:21:29 INFO - Running setup.py install for blobuploader 15:21:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:21:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:21:29 INFO - Running setup.py install for requests 15:21:29 INFO - Running setup.py install for docopt 15:21:30 INFO - Successfully installed blobuploader requests docopt 15:21:30 INFO - Cleaning up... 15:21:30 INFO - Return code: 0 15:21:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:30 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')]} 15:21:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:30 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')]} 15:21:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:30 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:30 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 15:21:30 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 15:21:30 INFO - Using env: {'DISPLAY': ':0', 15:21:30 INFO - 'HOME': '/home/cltbld', 15:21:30 INFO - 'LANG': 'en_US.UTF-8', 15:21:30 INFO - 'LANGUAGE': 'en_US:en', 15:21:30 INFO - 'LOGNAME': 'cltbld', 15:21:30 INFO - 'MAIL': '/var/mail/cltbld', 15:21:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:30 INFO - 'MOZ_NO_REMOTE': '1', 15:21:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:30 INFO - 'NO_EM_RESTART': '1', 15:21:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:30 INFO - 'PWD': '/builds/slave/test', 15:21:30 INFO - 'SHELL': '/bin/bash', 15:21:30 INFO - 'SHLVL': '1', 15:21:30 INFO - 'TERM': 'linux', 15:21:30 INFO - 'TMOUT': '86400', 15:21:30 INFO - 'USER': 'cltbld', 15:21:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:30 INFO - '_': '/tools/buildbot/bin/python'} 15:21:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:30 INFO - Running setup.py (path:/tmp/pip-fTMW72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:30 INFO - Running setup.py (path:/tmp/pip-Myl1Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:30 INFO - Running setup.py (path:/tmp/pip-W5HSPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:30 INFO - Running setup.py (path:/tmp/pip-e7R3LW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:30 INFO - Running setup.py (path:/tmp/pip-e2Gcom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:30 INFO - Running setup.py (path:/tmp/pip-HOY6uM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:30 INFO - Running setup.py (path:/tmp/pip-Oo6pjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:30 INFO - Running setup.py (path:/tmp/pip-VNhY_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:30 INFO - Running setup.py (path:/tmp/pip-_VKtT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:31 INFO - Running setup.py (path:/tmp/pip-Qm7hoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:31 INFO - Running setup.py (path:/tmp/pip-vte9wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:31 INFO - Running setup.py (path:/tmp/pip-jAgtdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:31 INFO - Running setup.py (path:/tmp/pip-gtJxX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:31 INFO - Running setup.py (path:/tmp/pip-mQB2ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:31 INFO - Running setup.py (path:/tmp/pip-uMhRGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:31 INFO - Running setup.py (path:/tmp/pip-L0QKea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:31 INFO - Running setup.py (path:/tmp/pip-xouWJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:21:31 INFO - Running setup.py install for manifestparser 15:21:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:21:31 INFO - Running setup.py install for mozcrash 15:21:31 INFO - Running setup.py install for mozdebug 15:21:31 INFO - Running setup.py install for mozdevice 15:21:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozfile 15:21:32 INFO - Running setup.py install for mozhttpd 15:21:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozinfo 15:21:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozInstall 15:21:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozleak 15:21:32 INFO - Running setup.py install for mozlog 15:21:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for moznetwork 15:21:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozprocess 15:21:32 INFO - Running setup.py install for mozprofile 15:21:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:21:32 INFO - Running setup.py install for mozrunner 15:21:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:21:33 INFO - Running setup.py install for mozscreenshot 15:21:33 INFO - Running setup.py install for moztest 15:21:33 INFO - Running setup.py install for mozversion 15:21:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:21:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:21:33 INFO - Cleaning up... 15:21:33 INFO - Return code: 0 15:21:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:33 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')]} 15:21:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:33 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')]} 15:21:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:33 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:33 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 15:21:33 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 15:21:33 INFO - Using env: {'DISPLAY': ':0', 15:21:33 INFO - 'HOME': '/home/cltbld', 15:21:33 INFO - 'LANG': 'en_US.UTF-8', 15:21:33 INFO - 'LANGUAGE': 'en_US:en', 15:21:33 INFO - 'LOGNAME': 'cltbld', 15:21:33 INFO - 'MAIL': '/var/mail/cltbld', 15:21:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:33 INFO - 'MOZ_NO_REMOTE': '1', 15:21:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:33 INFO - 'NO_EM_RESTART': '1', 15:21:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:33 INFO - 'PWD': '/builds/slave/test', 15:21:33 INFO - 'SHELL': '/bin/bash', 15:21:33 INFO - 'SHLVL': '1', 15:21:33 INFO - 'TERM': 'linux', 15:21:33 INFO - 'TMOUT': '86400', 15:21:33 INFO - 'USER': 'cltbld', 15:21:33 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:33 INFO - '_': '/tools/buildbot/bin/python'} 15:21:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:21:33 INFO - Running setup.py (path:/tmp/pip-vIGk6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:21:33 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)) 15:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:21:33 INFO - Running setup.py (path:/tmp/pip-oD9rra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:21:33 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)) 15:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:21:33 INFO - Running setup.py (path:/tmp/pip-cid0g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:21:33 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)) 15:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:21:33 INFO - Running setup.py (path:/tmp/pip-QgvX4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:21:33 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)) 15:21:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:21:33 INFO - Running setup.py (path:/tmp/pip-2tjwrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:21:34 INFO - Running setup.py (path:/tmp/pip-C_9ikI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:21:34 INFO - Running setup.py (path:/tmp/pip-YhLF4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:21:34 INFO - Running setup.py (path:/tmp/pip-Y7aP3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:21:34 INFO - Running setup.py (path:/tmp/pip-Wmt9n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:21:34 INFO - Running setup.py (path:/tmp/pip-9w_XVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:21:34 INFO - Running setup.py (path:/tmp/pip-NNo1ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:21:34 INFO - Running setup.py (path:/tmp/pip-WSMg5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:21:34 INFO - Running setup.py (path:/tmp/pip-qkwn87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:21:34 INFO - Running setup.py (path:/tmp/pip-HUMYK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:34 INFO - Running setup.py (path:/tmp/pip-Ccuq14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:21:34 INFO - Running setup.py (path:/tmp/pip-AMS_gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:21:34 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)) 15:21:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:21:34 INFO - Running setup.py (path:/tmp/pip-NHdmpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:21:34 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)) 15:21:34 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)) 15:21:34 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)) 15:21:34 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)) 15:21:34 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)) 15:21:34 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)) 15:21:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:34 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 15:21:36 INFO - Downloading blessings-1.6.tar.gz 15:21:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:21:36 INFO - Installing collected packages: blessings 15:21:36 INFO - Running setup.py install for blessings 15:21:36 INFO - Successfully installed blessings 15:21:36 INFO - Cleaning up... 15:21:36 INFO - Return code: 0 15:21:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:21:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:37 INFO - Reading from file tmpfile_stdout 15:21:37 INFO - Current package versions: 15:21:37 INFO - argparse == 1.2.1 15:21:37 INFO - blessings == 1.6 15:21:37 INFO - blobuploader == 1.2.4 15:21:37 INFO - docopt == 0.6.1 15:21:37 INFO - functools32 == 3.2.3-2 15:21:37 INFO - jsonschema == 2.5.1 15:21:37 INFO - manifestparser == 1.1 15:21:37 INFO - mozInstall == 1.12 15:21:37 INFO - mozcrash == 0.17 15:21:37 INFO - mozdebug == 0.1 15:21:37 INFO - mozdevice == 0.48 15:21:37 INFO - mozfile == 1.2 15:21:37 INFO - mozhttpd == 0.7 15:21:37 INFO - mozinfo == 0.9 15:21:37 INFO - mozleak == 0.1 15:21:37 INFO - mozlog == 3.4 15:21:37 INFO - moznetwork == 0.27 15:21:37 INFO - mozprocess == 0.23 15:21:37 INFO - mozprofile == 0.28 15:21:37 INFO - mozrunner == 6.12 15:21:37 INFO - mozscreenshot == 0.1 15:21:37 INFO - mozsystemmonitor == 0.3 15:21:37 INFO - moztest == 0.7 15:21:37 INFO - mozversion == 1.4 15:21:37 INFO - psutil == 3.1.1 15:21:37 INFO - requests == 1.2.3 15:21:37 INFO - wsgiref == 0.1.2 15:21:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:21:37 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')]} 15:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:37 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')]} 15:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:37 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:37 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 15:21:37 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 15:21:37 INFO - Using env: {'DISPLAY': ':0', 15:21:37 INFO - 'HOME': '/home/cltbld', 15:21:37 INFO - 'LANG': 'en_US.UTF-8', 15:21:37 INFO - 'LANGUAGE': 'en_US:en', 15:21:37 INFO - 'LOGNAME': 'cltbld', 15:21:37 INFO - 'MAIL': '/var/mail/cltbld', 15:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:37 INFO - 'MOZ_NO_REMOTE': '1', 15:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:37 INFO - 'NO_EM_RESTART': '1', 15:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:37 INFO - 'PWD': '/builds/slave/test', 15:21:37 INFO - 'SHELL': '/bin/bash', 15:21:37 INFO - 'SHLVL': '1', 15:21:37 INFO - 'TERM': 'linux', 15:21:37 INFO - 'TMOUT': '86400', 15:21:37 INFO - 'USER': 'cltbld', 15:21:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:37 INFO - '_': '/tools/buildbot/bin/python'} 15:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 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)) 15:21:37 INFO - Cleaning up... 15:21:37 INFO - Return code: 0 15:21:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:21:37 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')]} 15:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:37 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')]} 15:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:21:37 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 0x7fa886948f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2afa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc7790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', '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 15:21:37 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 15:21:37 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 15:21:37 INFO - Using env: {'DISPLAY': ':0', 15:21:37 INFO - 'HOME': '/home/cltbld', 15:21:37 INFO - 'LANG': 'en_US.UTF-8', 15:21:37 INFO - 'LANGUAGE': 'en_US:en', 15:21:37 INFO - 'LOGNAME': 'cltbld', 15:21:37 INFO - 'MAIL': '/var/mail/cltbld', 15:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:37 INFO - 'MOZ_NO_REMOTE': '1', 15:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:37 INFO - 'NO_EM_RESTART': '1', 15:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:37 INFO - 'PWD': '/builds/slave/test', 15:21:37 INFO - 'SHELL': '/bin/bash', 15:21:37 INFO - 'SHLVL': '1', 15:21:37 INFO - 'TERM': 'linux', 15:21:37 INFO - 'TMOUT': '86400', 15:21:37 INFO - 'USER': 'cltbld', 15:21:37 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:37 INFO - '_': '/tools/buildbot/bin/python'} 15:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:21:37 INFO - Cleaning up... 15:21:37 INFO - Return code: 0 15:21:37 INFO - Running post-action listener: _resource_record_post_action 15:21:37 INFO - Running post-action listener: _start_resource_monitoring 15:21:37 INFO - Starting resource monitoring. 15:21:37 INFO - [mozharness: 2016-10-09 22:21:37.706178Z] Finished create-virtualenv step (success) 15:21:37 INFO - [mozharness: 2016-10-09 22:21:37.706701Z] Running install step. 15:21:37 INFO - Running pre-action listener: _resource_record_pre_action 15:21:37 INFO - Running main action method: install 15:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:21:37 INFO - Reading from file tmpfile_stdout 15:21:37 INFO - Detecting whether we're running mozinstall >=1.0... 15:21:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:21:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:21:37 INFO - Reading from file tmpfile_stdout 15:21:37 INFO - Output received: 15:21:37 INFO - Usage: mozinstall [options] installer 15:21:37 INFO - Options: 15:21:37 INFO - -h, --help show this help message and exit 15:21:37 INFO - -d DEST, --destination=DEST 15:21:37 INFO - Directory to install application into. [default: 15:21:37 INFO - "/builds/slave/test"] 15:21:37 INFO - --app=APP Application being installed. [default: firefox] 15:21:37 INFO - mkdir: /builds/slave/test/build/application 15:21:37 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'] 15:21:37 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 15:21:55 INFO - Reading from file tmpfile_stdout 15:21:55 INFO - Output received: 15:21:55 INFO - /builds/slave/test/build/application/firefox/firefox 15:21:55 INFO - Running post-action listener: _resource_record_post_action 15:21:55 INFO - [mozharness: 2016-10-09 22:21:55.417924Z] Finished install step (success) 15:21:55 INFO - [mozharness: 2016-10-09 22:21:55.418251Z] Running run-tests step. 15:21:55 INFO - Running pre-action listener: _resource_record_pre_action 15:21:55 INFO - Running main action method: run_tests 15:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:55 INFO - Python 2.7.3 15:21:55 INFO - Return code: 0 15:21:55 INFO - grabbing minidump binary from tooltool 15:21:55 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')]} 15:21:55 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 0x2bc4930>, '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 0x2bc5830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bc5cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:55 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 15:21:55 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 15:21:55 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 15:21:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:55 INFO - Return code: 0 15:21:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:21:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:21:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:21:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:21:55 INFO - Using env: {'DISPLAY': ':0', 15:21:55 INFO - 'HOME': '/home/cltbld', 15:21:55 INFO - 'LANG': 'en_US.UTF-8', 15:21:55 INFO - 'LANGUAGE': 'en_US:en', 15:21:55 INFO - 'LOGNAME': 'cltbld', 15:21:55 INFO - 'MAIL': '/var/mail/cltbld', 15:21:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:55 INFO - 'MOZ_NO_REMOTE': '1', 15:21:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:55 INFO - 'NO_EM_RESTART': '1', 15:21:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:55 INFO - 'PWD': '/builds/slave/test', 15:21:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:55 INFO - 'SHELL': '/bin/bash', 15:21:55 INFO - 'SHLVL': '1', 15:21:55 INFO - 'TERM': 'linux', 15:21:55 INFO - 'TMOUT': '86400', 15:21:55 INFO - 'USER': 'cltbld', 15:21:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524', 15:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:55 INFO - '_': '/tools/buildbot/bin/python'} 15:21:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:21:55 INFO - mozversion application_buildid: 20161009123001 15:21:55 INFO - mozversion application_changeset: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 15:21:55 INFO - mozversion application_display_name: Nightly 15:21:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:55 INFO - mozversion application_name: Firefox 15:21:55 INFO - mozversion application_remotingname: firefox 15:21:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:21:55 INFO - mozversion application_vendor: Mozilla 15:21:55 INFO - mozversion application_version: 52.0a1 15:21:55 INFO - mozversion platform_buildid: 20161009123001 15:21:55 INFO - mozversion platform_changeset: d72cf6ecebaf707c159f6697d9f5f6f6a6feb7e1 15:21:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:21:55 INFO - mozversion platform_version: 52.0a1 15:21:55 INFO - using testdate: 1476051715 15:21:55 INFO - actual date: 1476051715 15:21:55 INFO - starting webserver on 'localhost:39269' 15:21:55 INFO - SUITE-START | Running 2 tests 15:21:55 INFO - TEST-START | dromaeo_css 15:21:55 INFO - operating with platform_type : linux_ 15:21:55 INFO - Initialising browser for dromaeo_css test... 15:21:55 INFO - TEST-INFO | started process 19112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIx7Ut8/profile http://localhost:39269/getInfo.html) 15:22:00 INFO - PROCESS | 19112 | __metrics Screen width/height:1600/1200 15:22:00 INFO - PROCESS | 19112 | colorDepth:24 15:22:00 INFO - PROCESS | 19112 | Browser inner width/height: 1024/697 15:22:00 INFO - PROCESS | 19112 | __metrics 15:22:00 INFO - PROCESS | 19112 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:22:00 INFO - PROCESS | 19112 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:22:01 INFO - PROCESS | 19112 | console.error: PushService: 15:22:01 INFO - PROCESS | 19112 | stateChangeProcessEnqueue: Error transitioning state 15:22:01 INFO - PROCESS | 19112 | UnknownError 15:22:02 INFO - TEST-INFO | 19112: exit 0 15:22:02 INFO - Browser initialized. 15:22:02 INFO - Running cycle 1/1 for dromaeo_css test... 15:22:02 INFO - TEST-INFO | started process 19197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIx7Ut8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:14 INFO - PROCESS | 19197 | RSS: Main: 173555712 15:22:14 INFO - PROCESS | 19197 | 15:23:05 INFO - PROCESS | 19197 | 1476051785649 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] 15:25:16 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39269/tests/dromaeo/cssquery-ext.html) 15:25:17 INFO - PROCESS | 19197 | RSS: Main: 299405312 15:25:17 INFO - PROCESS | 19197 | 15:28:19 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-ext.html (next: http://localhost:39269/tests/dromaeo/cssquery-jquery.html) 15:28:20 INFO - PROCESS | 19197 | RSS: Main: 275447808 15:28:20 INFO - PROCESS | 19197 | 15:31:22 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39269/tests/dromaeo/cssquery-mootools.html) 15:31:22 INFO - PROCESS | 19197 | RSS: Main: 213032960 15:31:22 INFO - PROCESS | 19197 | 15:34:24 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39269/tests/dromaeo/cssquery-prototype.html) 15:34:25 INFO - PROCESS | 19197 | RSS: Main: 240390144 15:34:25 INFO - PROCESS | 19197 | 15:37:28 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39269/tests/dromaeo/cssquery-yui.html) 15:37:28 INFO - PROCESS | 19197 | RSS: Main: 214949888 15:37:28 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | Cycle 1(1): loaded http://localhost:39269/tests/dromaeo/cssquery-yui.html (next: http://localhost:39269/tests/dromaeo/cssquery-dojo.html) 15:40:31 INFO - PROCESS | 19197 | RSS: Main: 305741824 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | __start_tp_report 15:40:31 INFO - PROCESS | 19197 | _x_x_mozilla_page_load 15:40:31 INFO - PROCESS | 19197 | _x_x_mozilla_page_load_details 15:40:31 INFO - PROCESS | 19197 | |i|pagename|runs| 15:40:31 INFO - PROCESS | 19197 | |0;dojo.html;3011.47299222636;3037.6354837419512;3045.0103716292206;3069.831159286241;3089.799163054401;5105.872353191172;5188.403333616635;5252.65857719248;5256.632035757494;5303;5251.86870328242;5266.631335806495;5300.496452836975;5351.063563876325;5391.32608423947;4777.044591081798;4785.808567657289;4806.086843499741;4814.109389762888;4902.3872015998;4877.0489754497885;4898.314236006961;4913.410390753114;4916.866144788761;4949.331840201563;4706.670533062687;4752.738599377033;4762.785674644632;4769.332293478881;4771.045790841846;4747.311639812242;4792.688475249098;4821.035792841446;4860.392450943632;4871.853844384674;4759.4764575896625;4761.285807128958;4767.809287628491;4787.8563643090765;4796.112719146969;5274.7626356814035;5282.947170528284;5301.6818990860675;5306.51853172128;5318.042752304584;5509.201165830972;5551.944480555183;5564.10974244123;5611.887762244733;5613.410591887834;5631.831045068655;5646.915296270559;5648.548116150698;5652.858678533028;5716.628419152742;5288.021715982555;5288.312519372495;5290.074237008508;5290.65610735301;5313.8937221255355;5580.19087232349;5613.663180209201;5631.915521267184;5678.4037676044245;5724.856878577985;5425.050616142159;5475.4524547544925;5478.506934375846;5529.419410961871;5546.833594992157;5508.173773933861;5546.63946843462;5556.472135147154;5557.666540007613;5567.916481252784;5423.511883930465;5468.699221542854;5473.644213126214;5597.524210442077;5607.859803504945;5522.392536820947;5560.944390556124;5572.665640061609;5578.832635020955;5665.178549110356;4336.176126535948;4347.543507931685;4348.108637729258;4393.165298593257;4395.648348132142;3836.7889766062576;3871.1483473636317;3876.573576906538;3883.3204189266767;3928.7642741435607;5247.10799164143;5281.867953301198;5286.788528458896;5331.120365139786;5331.680099193984;5591.860203494945;5694.003549378842;5706.28671416073;5710.71446427677;5729.942700573024;5222.4255331913455;5257.132573125468;5318.787248510093;5321.361436627552;5325.227841962894;4863.829765958245;4870.512948705101;4882.829100981448;4885.975570122127;4937.7777999990085;5653.378128405872;5718.857028574319;5734.54123670097;5772;5782.884342313214;5613.663180209201;5613.887722245614;5616.971915140562;5623.8875222496135;5676.347220069745;5796.565257605612;5800.303963524404;5810.5351571875;5813.215215945793;5815.302163740378;5261.947380526299;5311.654742441729;5421.674699518042;5474.753636086465;5485.588580856372;5656.519195868397;5656.971715141398;5663.915041274467;5667.801626943037;5680.40355762639;5488.917666235089;5495.313085864267;5496.862578435571;5499.615026948075;5500.4499550044675;5369.436209197978;5420.4037555868035;5445.918311225256;5498.395176530658;5578.888422231614;5475.2334673145;5500.22996780443;5529.972350138223;5586.86032849182;5599.692016939108;5561.749721262634;5564.972175139098;5566.888662226814;5567.220589117445;5580.2745643067765;5268.420473747808;5321.574274058144;5382.892342153214;5406.756695948613;5531.612787105025 15:40:31 INFO - PROCESS | 19197 | |1;ext.html;558.9245451864;588.920495733076;616.8735409241106;623.1991890420809;624.4036944717795;43608.345874811865;44719.55280447195;44936.775316123414;44939.32591011129;49204.50795492044;46861.297080543736;47422.52577474233;47458.28812567814;47513;47598.28602570964;9066.682666106688;9224.953875230649;9226.86159707605;9227;9227;8957.238634716057;8970.910290897105;9060.637574497012;9062.320325975545;9068.77328066797;9077.409968352069;9110.59002344896;9112.179903808656;9113.225375843029;9114.088591140899;9062.773430664252;9088.318376121751;9092.63629454821;9098.499582522958;9101.36290459668;9022;9077.228435582983;9095.681651142244;9095.727128186165;9101.453912765255;44241.77879110616;44450.55549444529;44544.77727611374;44666.776666116784;44703.32945005828;3417.9829100854586;3506.2286297014616;3566.857325706969;3865.3042452358563;4223.66210703143;32232.516512252336;32457.188570285933;32819.6718032819;32858.50712239318;32944.17639559006;4345.50026746925;4424.60178583929;4426.756528390937;4479.7984090716;4572.177008138534;328605;328848;329344;331702;338157;58576.12135817966;58856;58878.116828247614;58897;59093;61914.69042654758;61984.38015619786;62355;62425.68787156126;62552.68723656353;16410.343586256655;16607.252673629715;16653;16748.330066797436;16772;13170.407331670098;13241.801372979413;13245.801312980313;13247.602571922858;13255;16527;17586.27412751;17777.644447110986;17853.196606152753;17996.820031799776;5544.584156188302;5596.916046259309;5721.082248053523;5778.797742079007;5838.4453476919625;954.9713508594754;984.8276551603441;1027.6608719122821;1036.9533370998324;1086.4839201379282;31673;31795.019233057286;32004.544457953853;32193.678063219537;32196.35607287841;1119.1869171941344;1139.9430028498707;1149.597640825721;1207.209277922962;1209.5766481731323;15400.753254278185;16419.42532011374;16445.91777041107;16472.670546589;16646.16769161537;550750;556592;556731;556749;556858;58028.419715803146;58073.22524035924;58186.709066454394;58313.70843145757;58391.70804145952;1217.9330136842382;1275.4643049919057;1327.289899903547;1345.6232254968625;1345.7013981507891;30486.390272194876;33460.66539334576;33589;33658.49512257367;33901.66098338985;50894.745526272134;51324.23013654873;51399.97200056053;51426;51477.48522514877;407019;409712;411112;411636;412143;27806.86096569585;28561.714382855906;28649.713502864706;28758.42483150367;30538.389232214788;47866.76066619784;48105.518944811505;48118.75940620274;48228.51771482381;48593.75703121462;39794.60205398025;41023.7948810254;41623.7918810404;41784.3732344009;42883.7855810719;40763.59236407598;40826.59173408228;41130.79434602927;42124.368134478624;42285.57714422816;33450.33099337951;39962.40056399098;41157.382639259835;41242;44385.33421998608;31297.687023129478;34792.652073478945;35083.47374789431;35715.28569428545;36240.637593623724;26439.735602643726;26767.196984090508;26865.597016044383;27065;27280.181594552196 15:40:31 INFO - PROCESS | 19197 | |2;jquery.html;385.4699787791788;385.88809245318856;392.6171982317241;392.7388286789284;417.90388210711535;14389.424423023092;16390.26243819028;17903.731444028333;19454.22183112674;19477.318293859717;14844.55466336009;16710.24803883825;18128.093595320213;18271.90864045678;18651.440456786317;5172.27588137661;5421.078416669156;5440.292761940942;5463.699496527689;5482.095454250064;5425.593080518957;5496.725163741817;5504.394516603171;5507.146392309199;5604.187392828037;5937.1984782054515;5958.5828991970575;5989.520838332945;5998.790042348519;5999.640021598696;5680.147977803321;5969.761209551591;5974.61165024272;5974.701264936779;5978.8804223915495;5887.587868849182;5888.087346461305;5888.499477544414;5902.409759024106;5905.586608937376;15134.470293539784;21529.138834446603;22609.321720348416;22811.31566053021;22864.08543658268;2137.7114089597862;2375.3705268103968;2378.5718570657273;2385.976140238593;2463.6058230683007;10153.847692284622;10285.897141028643;10390.688279351632;10951.671449856518;11058.557657693682;1879.2670858365248;1905.8665893387467;1941.7766956799867;1944.8346890514324;1957.559549101455;80292.59853700752;81806;83408;86900.56549717337;87958;11094.889051109385;11142.66572002825;11282.943585282184;11332.263402878787;11697.649070527897;16051.518454446385;16072.11603361803;16072.276747546388;16085.517434476984;16099.356025759073;7346.816329591803;7677;7790.519801237747;8120.75637730869;8266.13205613414;7691.730789422343;7701.152873183945;7720;7865.921340786519;8032.919670803334;4770.308305295713;4901.289313049588;4926.261060840902;5020.949790502122;5030.119729047402;1902.8287454129195;1979.435860779671;2068.979310206909;2093.309207961369;2109.261758384553;951.8102372034956;955.441066975827;963.6145541783203;992.7270000749852;1003.1924300937669;19287;19453.805461945198;19548.511287217934;19574.510637234183;20134.19463221484;980.2892902645667;1001.4692213127055;1014.2697257974394;1018.8267994440963;1039.4698703661188;10142.239332050125;10856.72858178536;10941.890581094247;10970;11071.50178241965;450580;453364;458192;467228;468493;91286;94584;96539;96893;96987.51506242565;964.1033838530234;986.3342243985281;998.5406712912142;1001.5092604623682;1018.2363227579316;16430.67138657244;16709.665806684043;16778.916105419394;17272.91363543174;17655.823441765417;42057;42403;42784;43720.34419483646;44590.55409445864;41244.7636146018;49143.754281228365;54132;59208.40791592029;60389.094163586706;8404.873926891223;8695.695650652196;8752.606132723915;8821.823563528822;9073.909260907307;12972.675683107998;13176.73646527045;13219.801702974271;13399.866001340251;13757.587272381845;11413.942930285295;11494.770104598028;11514.82727759101;11938.880611194125;12023.338716370683;5479;9359.549269863182;11102.666919992413;11293.103879161676;11687.123465739933;11383.203175777617;11472.942635287103;11585.246958947642;12002.459889304828;12308.50765969387;7527.435442341955;8602.673388177223;8701.260392866678;8710.82578348442;9074.137956894348;9986.750331241778;11426.82859757121;11491.367974761133;11547.422628868691;11875.94062029719 15:40:31 INFO - PROCESS | 19197 | |3;mootools.html;1467.9412823487062;1500.5648361975027;1609.64587790686;1712.537614843992;1715.7683712698781;7735.30382265596;8019.117897031322;8392.28665563427;9081.954590227047;9085.136911993359;8295.709650162245;8606.827863442728;8614.095519970391;8854.247388971946;8865.689700860472;2357.3752955466816;2381.666566680666;2385.3440303916477;2400.855948643078;2403.2189538400003;1984.9603007939832;2060.8866512341815;2306.9884650576723;2336.5560543496767;2364.527094581082;2105.52625659227;2135.8184554312825;2220.478971904243;2283.600369935263;2299.3217000984664;2300.7469178390365;2301.286601153631;2302.781235782598;2304.0553373117027;2309.1340747219792;2247.449374903143;2271.5456908618344;2274.5450909817937;2281.190177486985;2282.281081459335;8743.868841967376;8750.693725719633;8846.292296616255;8866.778330541789;8868.113188681145;5243.580513558906;5369.785208591652;5407.621466497347;5409.134538473864;5413.188021796723;3414.470757032664;3482.407990641597;3619.3666108431185;3628.89113326598;3639.1448009717697;1214.9392530373445;1218.0986070307997;1224.7550489901967;1253.642711827125;1259.8551166615864;12180.878191218064;12186.329751863645;12291.078169137261;12337.136400451973;12338.444769985283;4344.630706389929;4512.72923624577;4668.836590719308;4702.57676809082;4710.199266124699;10352.792944141074;10361.481925903674;10367.896321036693;10370.377777333384;10380.273380863418;5397.055515284809;5404.54061404785;5438.864028399243;5449.128139497661;5453.15476101205;4812.51874812516;4953.8018479261145;4996.375453068366;5024.2463630454995;5025.070361983045;3675.9081022974638;3761.3417651910804;3784.413415920537;3800.5819359870393;3874.3219936511;1140.378493720924;1149.6665966869682;1159.750653609461;1162.686074759827;1173.8650055243586;760.4752720622753;830.2735106781566;918.554501066982;928.967486137982;944.900785417535;5571.442855714477;5915;5956.76172953077;6056.06131049688;6157.415045570664;463.1200718634621;463.7982477622245;473.49336210254694;474.1228726855359;628.3088602537173;3684.705223582107;3743.513343265358;3779.905502362463;3969.64273215412;4336.978315108404;10832.620858269922;11008.889911100787;11149.052330551995;11151.721206969729;11167.83248251277;11063.446827658585;11077.390743509022;11081.944590277159;11092.500837462334;11100.278481898651;7725.884111738328;8041.316488098577;8044.919550804534;8242.917570824215;8247.587620618946;5798.420157984167;5842.037202824926;5911.467967882912;5939.198208241832;6012.278526576839;9944.204463643036;10109.292349535463;10120.797584048425;10122.949385253027;10128.797424051625;9640.228781697308;10025.949870250603;10026.598936042477;10134.594616215269;10158.339707918962;7717.729879454192;7905.960470197612;7912.3889116590235;7913.366930645419;7917.604119793872;8068.139366921431;8257.339412846837;8270.545120018456;8320.500769953822;8341.24928756415;7532.924670753222;7610.429217808576;7678.692852285846;7680.769576912701;7755.7673269802;7393.297636724503;7456.7390141344795;7459;7616.314531692175;7739.032620922385;6417.935820641734;6506.479481641552;6622.039804228263;6628.635425051669;6642.070110184482;4664.067186562769;4692.906141877075;4729.408823897013;4805.879853003703;4914.459409465027;4822.614190864792;4828.565429111397;4940.728259945594;4975.950240497548;5034.647574669738 15:40:31 INFO - PROCESS | 19197 | |4;prototype.html;331.1274790925911;334.22960077022464;339.7519810538307;342.89884484077197;346.69664043961535;5216.217567364897;5276.894462110756;5282.498162674539;5312.150055991042;5317.654352467087;4964.602831773458;5097.464766199551;5125.513076257759;5177.430482646906;5235.450277720832;4166.208420400114;4167.395727619493;4172.895677608054;4176.644985176248;4182.16356728654;4169.812358443862;4181.289180839264;4192.958070419302;4194.559571245006;4197;3892.4355968384566;3966.7619942803526;4036.677065834741;4148.274052040896;4161.167766446708;4097.487814023247;4106.767969609105;4140.047789008515;4149.6265336119595;4149.730267532601;3697.149655579205;3701.68535674468;3711.0722319420147;3711.981440092782;3714;4940.55535001848;5078.511529350629;5112.36095488064;5123.129068058439;5130.53825155734;4720.787564559569;4748.620110391161;4754.643401744848;4758.643101767381;4769.9012434528695;5462.562994960394;5465.508104270635;5480.780768769284;5483.972580137074;5485.945140548623;3925.7448265862913;4073.5111786585503;4097.057676734338;4109.486314210723;4122.793860307002;5697.31632204134;5702.914456283159;5703;5710.800121995751;5713.885722285572;4190.937135942963;4193.266178418765;4194.224068547329;4195.091233488755;4209.726367786146;3926.4895563577124;4109.712320137562;4226.894327641833;4228.429162063144;4228.70399072062;4704.647151463654;4711.95288047122;4713.34013238147;4722.574968252874;4761.000569641174;5485.6560142765275;5485.6982865942755;5521.475459831309;5521.613487055867;5538;1369.9178049317072;1417.6810217700934;1431.914085154894;1434.2541878223265;1441.1641248076091;933.659214386744;946.1957336264257;969.2682025071167;1000.6497725796058;1001.1490233301636;5229.686218826807;5267.340787651954;5287.603429742785;5311.707856067954;5322.627416080914;5607.046802043581;5635.774569017193;5639.971800140973;5654.151877218368;5655.349634791969;5215.55667768244;5309.203619457112;5328.760205790749;5334.199870019528;5346.679199248058;2988.8804447821844;2999.4301082794636;3003.7296643302207;3011.382666553351;3015.638123425203;5636.60543761941;5796.246487956623;5812.564057695689;5819.854503637443;5839.766409343663;5717.599768016199;5721.685307308055;5723.427657234243;5724.395400092948;5736.139579063174;5820.592558520948;5838.649681019152;5845.626277824623;5849.532037436995;5853.824385268364;5320.760565774472;5534.418886016911;5566.554675625859;5601.507329238612;5620.3536593290655;5519.834404967857;5543.3967920851765;5544;5546.694931778791;5551.0301988435995;5650.491455769001;5789.1605717171615;5808.664007278265;5832.096025116114;5847.239858818326;4112.77379744105;4166.854160104382;4171.833126674899;4172.7913604320265;4176.164767046542;5723.370429252695;5727.513161381329;5731.08008817051;5735.569832262514;5754.935336962675;5294.9205761912835;5543.52880005204;5549;5574.358948720949;5603.747831347518;5439.619226654097;5549.750261238335;5553.916691249554;5568.805091821767;5576.525995290446;5276.287701160294;5469.097598896296;5553.527950124285;5570.192322113352;5582.302212223472;5407.134858422633;5574.386817450159;5585.301837270341;5595.300587426572;5599.160125980972;5493.368262649687;5497.092979658471;5504.972475137599;5506.146547285177;5508.438576062151 15:40:31 INFO - PROCESS | 19197 | |5;yui.html;689.1970853955143;733.2154594583794;773.2151865856155;774.2760518914813;779.6941810976308;15556.611084722888;16717.331306747714;16803.24385402657;16822.411215607455;16834.410795622156;15200.087994720325;15356;15376.692466150671;15394.69210615787;15409.383624655;629.7103332467059;658.1444122640572;764.1021799385727;776.8562815879052;792.5165648954162;792.3542313014904;794.1224946434194;794.630496818979;794.9284564389204;794.9682012719484;833.649867055835;834.1366685480529;834.6160766047595;835.0605568735173;835.1481488881337;674.5682763031639;688.8863337549299;808.8099296665279;824.5094168969454;830.0288662265104;613.3529126771255;613.677819144948;613.7360934798035;614.023702313324;614.2291424262567;15406.922965385102;15437.382504699799;15451.922740386226;15452.072875627386;15458;14558.344874480674;14724.48464303755;14761.26193690322;14778.556643300719;15008.099514029193;13275.46898124074;13357.53248636293;13375.866241337559;13736.733438982556;13907.860921390758;3764.642358975893;4351.8476853309985;4369.060651959844;4407.449068866392;4448.3549885266775;67484.66257668729;78561.25035623783;78866;79014;79103.60448197722;11019.449027548591;11140.554377824796;11207.215494915277;11266.718332041764;11306.434678266054;20227.29204477836;20289.695654565192;20346.796532034492;20378.69431958522;20475.38573842787;8477.23704866565;8786.428882122642;8844.55777211137;9035.503047332328;9251.583678734338;4792.209285467929;4809.470958194595;4886.780094895738;4902.48523904992;4913.828016019494;3642.4354225095153;3721.813909304524;3750.5311836020496;3770.698344132463;3778.131029863147;593.5577994394117;642.0625886206097;651.6839332923528;657.4773055420952;665.5041993714714;600.69664819266;643.9310744164665;704.6793708862456;705.8306006558491;790.3124281874806;9815;9883.084490075446;10352.482375881176;10475.319104258198;10493.265471416928;601.8856417280703;700.7911352916179;720.2977097330062;730.2113717185428;746.4471507444553;4571.428571428572;4852.490488498657;4950.975245123824;5028.84913452597;5032.798688052437;113996;120829;121547.39226303989;124723;126955.36522317515;62434.37565624376;87665;98665;100468;101170.49414752879;23207.3037808866;71285;73777.26222737704;74428;76023;9296.39573427725;10005.240697761532;10175.898241017496;10530.21023423231;10589.152867770406;49231.753841230566;50029;51080;51340;53448.73275633597;69100.65449672719;73459.63270183615;74341.2565874356;75013.24986750062;75476;12687.429065692251;12962.870371296543;13004.934975325063;13571.457141714222;13898.525368657836;14682.894815345095;15166.620834479227;15498.690026199187;15715.371385144466;15923.44267950616;14096.788548171991;14658.413663453342;14941.103533788008;15233.3906643733;15236.31436585334;13747.931260343634;13983.440662373798;14013;14673.339699713326;15091;13696.178229306273;13699.383527741475;13738.313084345542;13927;14068.929655352067;11012.559497620005;11046.502907369348;11210.383428911487;11279.266847654877;11537.596184133516;10791.946040269748;12054.698632534257;12134.453949572115;12234.816477752664;12400.62798116058 15:40:31 INFO - PROCESS | 19197 | __end_tp_report 15:40:31 INFO - PROCESS | 19197 | __start_cc_report 15:40:31 INFO - PROCESS | 19197 | _x_x_mozilla_cycle_collect,1157 15:40:31 INFO - PROCESS | 19197 | __end_cc_report 15:40:31 INFO - PROCESS | 19197 | __startTimestamp1476052831937__endTimestamp 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | ------- Summary: start ------- 15:40:31 INFO - PROCESS | 19197 | Number of tests: 6 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#0] dojo.html Cycles:165 Average:5222.19 Median:5420.40 stddev:573.07 (10.6%) stddev-sans-first:547.96 15:40:31 INFO - PROCESS | 19197 | Values: 3011.5 3037.6 3045.0 3069.8 3089.8 5105.9 5188.4 5252.7 5256.6 5303.0 5251.9 5266.6 5300.5 5351.1 5391.3 4777.0 4785.8 4806.1 4814.1 4902.4 4877.0 4898.3 4913.4 4916.9 4949.3 4706.7 4752.7 4762.8 4769.3 4771.0 4747.3 4792.7 4821.0 4860.4 4871.9 4759.5 4761.3 4767.8 4787.9 4796.1 5274.8 5282.9 5301.7 5306.5 5318.0 5509.2 5551.9 5564.1 5611.9 5613.4 5631.8 5646.9 5648.5 5652.9 5716.6 5288.0 5288.3 5290.1 5290.7 5313.9 5580.2 5613.7 5631.9 5678.4 5724.9 5425.1 5475.5 5478.5 5529.4 5546.8 5508.2 5546.6 5556.5 5557.7 5567.9 5423.5 5468.7 5473.6 5597.5 5607.9 5522.4 5560.9 5572.7 5578.8 5665.2 4336.2 4347.5 4348.1 4393.2 4395.6 3836.8 3871.1 3876.6 3883.3 3928.8 5247.1 5281.9 5286.8 5331.1 5331.7 5591.9 5694.0 5706.3 5710.7 5729.9 5222.4 5257.1 5318.8 5321.4 5325.2 4863.8 4870.5 4882.8 4886.0 4937.8 5653.4 5718.9 5734.5 5772.0 5782.9 5613.7 5613.9 5617.0 5623.9 5676.3 5796.6 5800.3 5810.5 5813.2 5815.3 5261.9 5311.7 5421.7 5474.8 5485.6 5656.5 5657.0 5663.9 5667.8 5680.4 5488.9 5495.3 5496.9 5499.6 5500.4 5369.4 5420.4 5445.9 5498.4 5578.9 5475.2 5500.2 5530.0 5586.9 5599.7 5561.7 5565.0 5566.9 5567.2 5580.3 5268.4 5321.6 5382.9 5406.8 5531.6 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#1] ext.html Cycles:180 Average:59761.35 Median:42584.68 stddev:117313.43 (275.5%) stddev-sans-first:117558.32 15:40:31 INFO - PROCESS | 19197 | Values: 558.9 588.9 616.9 623.2 624.4 43608.3 44719.6 44936.8 44939.3 49204.5 46861.3 47422.5 47458.3 47513.0 47598.3 9066.7 9225.0 9226.9 9227.0 9227.0 8957.2 8970.9 9060.6 9062.3 9068.8 9077.4 9110.6 9112.2 9113.2 9114.1 9062.8 9088.3 9092.6 9098.5 9101.4 9022.0 9077.2 9095.7 9095.7 9101.5 44241.8 44450.6 44544.8 44666.8 44703.3 3418.0 3506.2 3566.9 3865.3 4223.7 32232.5 32457.2 32819.7 32858.5 32944.2 4345.5 4424.6 4426.8 4479.8 4572.2 328605.0 328848.0 329344.0 331702.0 338157.0 58576.1 58856.0 58878.1 58897.0 59093.0 61914.7 61984.4 62355.0 62425.7 62552.7 16410.3 16607.3 16653.0 16748.3 16772.0 13170.4 13241.8 13245.8 13247.6 13255.0 16527.0 17586.3 17777.6 17853.2 17996.8 5544.6 5596.9 5721.1 5778.8 5838.4 955.0 984.8 1027.7 1037.0 1086.5 31673.0 31795.0 32004.5 32193.7 32196.4 1119.2 1139.9 1149.6 1207.2 1209.6 15400.8 16419.4 16445.9 16472.7 16646.2 550750.0 556592.0 556731.0 556749.0 556858.0 58028.4 58073.2 58186.7 58313.7 58391.7 1217.9 1275.5 1327.3 1345.6 1345.7 30486.4 33460.7 33589.0 33658.5 33901.7 50894.7 51324.2 51400.0 51426.0 51477.5 407019.0 409712.0 411112.0 411636.0 412143.0 27806.9 28561.7 28649.7 28758.4 30538.4 47866.8 48105.5 48118.8 48228.5 48593.8 39794.6 41023.8 41623.8 41784.4 42883.8 40763.6 40826.6 41130.8 42124.4 42285.6 33450.3 39962.4 41157.4 41242.0 44385.3 31297.7 34792.7 35083.5 35715.3 36240.6 26439.7 26767.2 26865.6 27065.0 27280.2 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#2] jquery.html Cycles:180 Average:28055.20 Median:389.25 stddev:76092.51 (19548.4%) stddev-sans-first:76277.60 15:40:31 INFO - PROCESS | 19197 | Values: 385.5 385.9 392.6 392.7 417.9 14389.4 16390.3 17903.7 19454.2 19477.3 14844.6 16710.2 18128.1 18271.9 18651.4 5172.3 5421.1 5440.3 5463.7 5482.1 5425.6 5496.7 5504.4 5507.1 5604.2 5937.2 5958.6 5989.5 5998.8 5999.6 5680.1 5969.8 5974.6 5974.7 5978.9 5887.6 5888.1 5888.5 5902.4 5905.6 15134.5 21529.1 22609.3 22811.3 22864.1 2137.7 2375.4 2378.6 2386.0 2463.6 10153.8 10285.9 10390.7 10951.7 11058.6 1879.3 1905.9 1941.8 1944.8 1957.6 80292.6 81806.0 83408.0 86900.6 87958.0 11094.9 11142.7 11282.9 11332.3 11697.6 16051.5 16072.1 16072.3 16085.5 16099.4 7346.8 7677.0 7790.5 8120.8 8266.1 7691.7 7701.2 7720.0 7865.9 8032.9 4770.3 4901.3 4926.3 5020.9 5030.1 1902.8 1979.4 2069.0 2093.3 2109.3 951.8 955.4 963.6 992.7 1003.2 19287.0 19453.8 19548.5 19574.5 20134.2 980.3 1001.5 1014.3 1018.8 1039.5 10142.2 10856.7 10941.9 10970.0 11071.5 450580.0 453364.0 458192.0 467228.0 468493.0 91286.0 94584.0 96539.0 96893.0 96987.5 964.1 986.3 998.5 1001.5 1018.2 16430.7 16709.7 16778.9 17272.9 17655.8 42057.0 42403.0 42784.0 43720.3 44590.6 41244.8 49143.8 54132.0 59208.4 60389.1 8404.9 8695.7 8752.6 8821.8 9073.9 12972.7 13176.7 13219.8 13399.9 13757.6 11413.9 11494.8 11514.8 11938.9 12023.3 5479.0 9359.5 11102.7 11293.1 11687.1 11383.2 11472.9 11585.2 12002.5 12308.5 7527.4 8602.7 8701.3 8710.8 9074.1 9986.8 11426.8 11491.4 11547.4 11875.9 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#3] mootools.html Cycles:180 Average:5738.07 Median:4706.39 stddev:3313.63 (70.4%) stddev-sans-first:3307.39 15:40:31 INFO - PROCESS | 19197 | Values: 1467.9 1500.6 1609.6 1712.5 1715.8 7735.3 8019.1 8392.3 9082.0 9085.1 8295.7 8606.8 8614.1 8854.2 8865.7 2357.4 2381.7 2385.3 2400.9 2403.2 1985.0 2060.9 2307.0 2336.6 2364.5 2105.5 2135.8 2220.5 2283.6 2299.3 2300.7 2301.3 2302.8 2304.1 2309.1 2247.4 2271.5 2274.5 2281.2 2282.3 8743.9 8750.7 8846.3 8866.8 8868.1 5243.6 5369.8 5407.6 5409.1 5413.2 3414.5 3482.4 3619.4 3628.9 3639.1 1214.9 1218.1 1224.8 1253.6 1259.9 12180.9 12186.3 12291.1 12337.1 12338.4 4344.6 4512.7 4668.8 4702.6 4710.2 10352.8 10361.5 10367.9 10370.4 10380.3 5397.1 5404.5 5438.9 5449.1 5453.2 4812.5 4953.8 4996.4 5024.2 5025.1 3675.9 3761.3 3784.4 3800.6 3874.3 1140.4 1149.7 1159.8 1162.7 1173.9 760.5 830.3 918.6 929.0 944.9 5571.4 5915.0 5956.8 6056.1 6157.4 463.1 463.8 473.5 474.1 628.3 3684.7 3743.5 3779.9 3969.6 4337.0 10832.6 11008.9 11149.1 11151.7 11167.8 11063.4 11077.4 11081.9 11092.5 11100.3 7725.9 8041.3 8044.9 8242.9 8247.6 5798.4 5842.0 5911.5 5939.2 6012.3 9944.2 10109.3 10120.8 10122.9 10128.8 9640.2 10025.9 10026.6 10134.6 10158.3 7717.7 7906.0 7912.4 7913.4 7917.6 8068.1 8257.3 8270.5 8320.5 8341.2 7532.9 7610.4 7678.7 7680.8 7755.8 7393.3 7456.7 7459.0 7616.3 7739.0 6417.9 6506.5 6622.0 6628.6 6642.1 4664.1 4692.9 4729.4 4805.9 4914.5 4822.6 4828.6 4940.7 4976.0 5034.6 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#4] prototype.html Cycles:180 Average:4665.01 Median:5302.06 stddev:1349.73 (25.5%) stddev-sans-first:1313.74 15:40:31 INFO - PROCESS | 19197 | Values: 331.1 334.2 339.8 342.9 346.7 5216.2 5276.9 5282.5 5312.2 5317.7 4964.6 5097.5 5125.5 5177.4 5235.5 4166.2 4167.4 4172.9 4176.6 4182.2 4169.8 4181.3 4193.0 4194.6 4197.0 3892.4 3966.8 4036.7 4148.3 4161.2 4097.5 4106.8 4140.0 4149.6 4149.7 3697.1 3701.7 3711.1 3712.0 3714.0 4940.6 5078.5 5112.4 5123.1 5130.5 4720.8 4748.6 4754.6 4758.6 4769.9 5462.6 5465.5 5480.8 5484.0 5485.9 3925.7 4073.5 4097.1 4109.5 4122.8 5697.3 5702.9 5703.0 5710.8 5713.9 4190.9 4193.3 4194.2 4195.1 4209.7 3926.5 4109.7 4226.9 4228.4 4228.7 4704.6 4712.0 4713.3 4722.6 4761.0 5485.7 5485.7 5521.5 5521.6 5538.0 1369.9 1417.7 1431.9 1434.3 1441.2 933.7 946.2 969.3 1000.6 1001.1 5229.7 5267.3 5287.6 5311.7 5322.6 5607.0 5635.8 5640.0 5654.2 5655.3 5215.6 5309.2 5328.8 5334.2 5346.7 2988.9 2999.4 3003.7 3011.4 3015.6 5636.6 5796.2 5812.6 5819.9 5839.8 5717.6 5721.7 5723.4 5724.4 5736.1 5820.6 5838.6 5845.6 5849.5 5853.8 5320.8 5534.4 5566.6 5601.5 5620.4 5519.8 5543.4 5544.0 5546.7 5551.0 5650.5 5789.2 5808.7 5832.1 5847.2 4112.8 4166.9 4171.8 4172.8 4176.2 5723.4 5727.5 5731.1 5735.6 5754.9 5294.9 5543.5 5549.0 5574.4 5603.7 5439.6 5549.8 5553.9 5568.8 5576.5 5276.3 5469.1 5553.5 5570.2 5582.3 5407.1 5574.4 5585.3 5595.3 5599.2 5493.4 5497.1 5505.0 5506.1 5508.4 15:40:31 INFO - PROCESS | 19197 | 15:40:31 INFO - PROCESS | 19197 | [#5] yui.html Cycles:180 Average:20330.48 Median:4064.99 stddev:28942.82 (712.0%) stddev-sans-first:28986.44 15:40:31 INFO - PROCESS | 19197 | Values: 689.2 733.2 773.2 774.3 779.7 15556.6 16717.3 16803.2 16822.4 16834.4 15200.1 15356.0 15376.7 15394.7 15409.4 629.7 658.1 764.1 776.9 792.5 792.4 794.1 794.6 794.9 795.0 833.6 834.1 834.6 835.1 835.1 674.6 688.9 808.8 824.5 830.0 613.4 613.7 613.7 614.0 614.2 15406.9 15437.4 15451.9 15452.1 15458.0 14558.3 14724.5 14761.3 14778.6 15008.1 13275.5 13357.5 13375.9 13736.7 13907.9 3764.6 4351.8 4369.1 4407.4 4448.4 67484.7 78561.3 78866.0 79014.0 79103.6 11019.4 11140.6 11207.2 11266.7 11306.4 20227.3 20289.7 20346.8 20378.7 20475.4 8477.2 8786.4 8844.6 9035.5 9251.6 4792.2 4809.5 4886.8 4902.5 4913.8 3642.4 3721.8 3750.5 3770.7 3778.1 593.6 642.1 651.7 657.5 665.5 600.7 643.9 704.7 705.8 790.3 9815.0 9883.1 10352.5 10475.3 10493.3 601.9 700.8 720.3 730.2 746.4 4571.4 4852.5 4951.0 5028.8 5032.8 113996.0 120829.0 121547.4 124723.0 126955.4 62434.4 87665.0 98665.0 100468.0 101170.5 23207.3 71285.0 73777.3 74428.0 76023.0 9296.4 10005.2 10175.9 10530.2 10589.2 49231.8 50029.0 51080.0 51340.0 53448.7 69100.7 73459.6 74341.3 75013.2 75476.0 12687.4 12962.9 13004.9 13571.5 13898.5 14682.9 15166.6 15498.7 15715.4 15923.4 14096.8 14658.4 14941.1 15233.4 15236.3 13747.9 13983.4 14013.0 14673.3 15091.0 13696.2 13699.4 13738.3 13927.0 14068.9 11012.6 11046.5 11210.4 11279.3 11537.6 10791.9 12054.7 12134.5 12234.8 12400.6 15:40:31 INFO - PROCESS | 19197 | -------- Summary: end -------- 15:40:31 INFO - PROCESS | 19197 | 15:40:32 INFO - TEST-INFO | 19197: exit 0 15:40:32 INFO - TEST-OK | dromaeo_css | took 1117217ms 15:40:32 INFO - TEST-START | kraken 15:40:32 INFO - operating with platform_type : linux_ 15:40:32 INFO - Initialising browser for kraken test... 15:40:32 INFO - TEST-INFO | started process 19506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzYzOs/profile http://localhost:39269/getInfo.html) 15:40:37 INFO - PROCESS | 19506 | __metrics Screen width/height:1600/1200 15:40:37 INFO - PROCESS | 19506 | colorDepth:24 15:40:37 INFO - PROCESS | 19506 | Browser inner width/height: 1024/697 15:40:37 INFO - PROCESS | 19506 | __metrics 15:40:38 INFO - PROCESS | 19506 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:40:38 INFO - PROCESS | 19506 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:38 INFO - PROCESS | 19506 | console.error: PushService: 15:40:38 INFO - PROCESS | 19506 | stateChangeProcessEnqueue: Error transitioning state 15:40:38 INFO - PROCESS | 19506 | UnknownError 15:40:39 INFO - TEST-INFO | 19506: exit 0 15:40:39 INFO - Browser initialized. 15:40:39 INFO - Running cycle 1/1 for kraken test... 15:40:39 INFO - TEST-INFO | started process 19591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzYzOs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:51 INFO - PROCESS | 19591 | RSS: Main: 172621824 15:40:51 INFO - PROCESS | 19591 | 15:40:53 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39269/tests/kraken/driver.html?testName=audio-beat-detection) 15:40:54 INFO - PROCESS | 19591 | RSS: Main: 231206912 15:40:54 INFO - PROCESS | 19591 | 15:40:57 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39269/tests/kraken/driver.html?testName=audio-dft) 15:40:58 INFO - PROCESS | 19591 | RSS: Main: 216621056 15:40:58 INFO - PROCESS | 19591 | 15:41:01 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39269/tests/kraken/driver.html?testName=audio-fft) 15:41:01 INFO - PROCESS | 19591 | RSS: Main: 297508864 15:41:01 INFO - PROCESS | 19591 | 15:41:03 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39269/tests/kraken/driver.html?testName=audio-oscillator) 15:41:04 INFO - PROCESS | 19591 | RSS: Main: 206995456 15:41:04 INFO - PROCESS | 19591 | 15:41:06 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:41:07 INFO - PROCESS | 19591 | RSS: Main: 212082688 15:41:07 INFO - PROCESS | 19591 | 15:41:10 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39269/tests/kraken/driver.html?testName=imaging-darkroom) 15:41:10 INFO - PROCESS | 19591 | RSS: Main: 248627200 15:41:10 INFO - PROCESS | 19591 | 15:41:14 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39269/tests/kraken/driver.html?testName=imaging-desaturate) 15:41:14 INFO - PROCESS | 19591 | RSS: Main: 246697984 15:41:14 INFO - PROCESS | 19591 | 15:41:17 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39269/tests/kraken/driver.html?testName=json-parse-financial) 15:41:18 INFO - PROCESS | 19591 | RSS: Main: 247255040 15:41:18 INFO - PROCESS | 19591 | 15:41:19 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:41:20 INFO - PROCESS | 19591 | RSS: Main: 209694720 15:41:20 INFO - PROCESS | 19591 | 15:41:22 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:41:22 INFO - PROCESS | 19591 | RSS: Main: 217038848 15:41:22 INFO - PROCESS | 19591 | 15:41:24 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:41:25 INFO - PROCESS | 19591 | RSS: Main: 225796096 15:41:25 INFO - PROCESS | 19591 | 15:41:28 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:41:28 INFO - PROCESS | 19591 | RSS: Main: 235470848 15:41:28 INFO - PROCESS | 19591 | 15:41:31 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:41:32 INFO - PROCESS | 19591 | RSS: Main: 231550976 15:41:32 INFO - PROCESS | 19591 | 15:41:33 INFO - PROCESS | 19591 | Cycle 1(1): loaded http://localhost:39269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39269/tests/kraken/driver.html?testName=ai-astar) 15:41:34 INFO - PROCESS | 19591 | RSS: Main: 282624000 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | __start_tp_report 15:41:34 INFO - PROCESS | 19591 | _x_x_mozilla_page_load 15:41:34 INFO - PROCESS | 19591 | _x_x_mozilla_page_load_details 15:41:34 INFO - PROCESS | 19591 | |i|pagename|runs| 15:41:34 INFO - PROCESS | 19591 | |0;ai-astar;111;112;112;112;112;112;111;111;111;110 15:41:34 INFO - PROCESS | 19591 | |1;audio-beat-detection;145;122;124;166;143;123;121;121;151;127 15:41:34 INFO - PROCESS | 19591 | |2;audio-dft;161;159;160;159;162;161;162;161;161;161 15:41:34 INFO - PROCESS | 19591 | |3;audio-fft;76;75;76;110;77;77;77;77;101;75 15:41:34 INFO - PROCESS | 19591 | |4;audio-oscillator;83;82;111;83;83;82;101;82;83;117 15:41:34 INFO - PROCESS | 19591 | |5;imaging-gaussian-blur;124;117;117;117;117;117;117;117;117;116 15:41:34 INFO - PROCESS | 19591 | |6;imaging-darkroom;146;146;146;146;146;145;145;146;146;145 15:41:34 INFO - PROCESS | 19591 | |7;imaging-desaturate;94;94;95;94;95;95;95;96;95;95 15:41:34 INFO - PROCESS | 19591 | |8;json-parse-financial;55;53;53;53;54;54;54;55;54;55 15:41:34 INFO - PROCESS | 19591 | |9;json-stringify-tinderbox;63;64;63;63;63;62;62;63;63;63 15:41:34 INFO - PROCESS | 19591 | |10;stanford-crypto-aes;80;79;86;79;78;78;87;78;81;78 15:41:34 INFO - PROCESS | 19591 | |11;stanford-crypto-ccm;129;132;133;140;133;141;133;129;190;131 15:41:34 INFO - PROCESS | 19591 | |12;stanford-crypto-pbkdf2;165;165;166;165;165;165;167;163;167;164 15:41:34 INFO - PROCESS | 19591 | |13;stanford-crypto-sha256-iterative;67;65;65;73;75;66;65;66;64;63 15:41:34 INFO - PROCESS | 19591 | __end_tp_report 15:41:34 INFO - PROCESS | 19591 | __start_cc_report 15:41:34 INFO - PROCESS | 19591 | _x_x_mozilla_cycle_collect,1664 15:41:34 INFO - PROCESS | 19591 | __end_cc_report 15:41:34 INFO - PROCESS | 19591 | __startTimestamp1476052894108__endTimestamp 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | ------- Summary: start ------- 15:41:34 INFO - PROCESS | 19591 | Number of tests: 14 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 15:41:34 INFO - PROCESS | 19591 | Values: 111.0 112.0 112.0 112.0 112.0 112.0 111.0 111.0 111.0 110.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:135.00 stddev:15.87 (11.8%) stddev-sans-first:16.35 15:41:34 INFO - PROCESS | 19591 | Values: 145.0 122.0 124.0 166.0 143.0 123.0 121.0 121.0 151.0 127.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 15:41:34 INFO - PROCESS | 19591 | Values: 161.0 159.0 160.0 159.0 162.0 161.0 162.0 161.0 161.0 161.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.50 stddev:12.54 (16.4%) stddev-sans-first:13.10 15:41:34 INFO - PROCESS | 19591 | Values: 76.0 75.0 76.0 110.0 77.0 77.0 77.0 77.0 101.0 75.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.50 stddev:13.64 (16.5%) stddev-sans-first:14.18 15:41:34 INFO - PROCESS | 19591 | Values: 83.0 82.0 111.0 83.0 83.0 82.0 101.0 82.0 83.0 117.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.00 stddev:2.27 (1.9%) stddev-sans-first:0.33 15:41:34 INFO - PROCESS | 19591 | Values: 124.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 15:41:34 INFO - PROCESS | 19591 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 15:41:34 INFO - PROCESS | 19591 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 95.0 96.0 95.0 95.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.78 15:41:34 INFO - PROCESS | 19591 | Values: 55.0 53.0 53.0 53.0 54.0 54.0 54.0 55.0 54.0 55.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 15:41:34 INFO - PROCESS | 19591 | Values: 63.0 64.0 63.0 63.0 63.0 62.0 62.0 63.0 63.0 63.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.50 stddev:3.37 (4.2%) stddev-sans-first:3.57 15:41:34 INFO - PROCESS | 19591 | Values: 80.0 79.0 86.0 79.0 78.0 78.0 87.0 78.0 81.0 78.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:133.00 stddev:18.34 (13.8%) stddev-sans-first:19.08 15:41:34 INFO - PROCESS | 19591 | Values: 129.0 132.0 133.0 140.0 133.0 141.0 133.0 129.0 190.0 131.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.00 stddev:1.23 (0.7%) stddev-sans-first:1.30 15:41:34 INFO - PROCESS | 19591 | Values: 165.0 165.0 166.0 165.0 165.0 165.0 167.0 163.0 167.0 164.0 15:41:34 INFO - PROCESS | 19591 | 15:41:34 INFO - PROCESS | 19591 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:66.00 stddev:3.93 (6.0%) stddev-sans-first:4.17 15:41:34 INFO - PROCESS | 19591 | Values: 67.0 65.0 65.0 73.0 75.0 66.0 65.0 66.0 64.0 63.0 15:41:34 INFO - PROCESS | 19591 | -------- Summary: end -------- 15:41:34 INFO - PROCESS | 19591 | 15:41:35 INFO - TEST-INFO | 19591: exit 0 15:41:35 INFO - TEST-OK | kraken | took 62375ms 15:41:35 INFO - SUITE-END | took 1179s 15:41:35 INFO - Completed test suite (00:19:40) 15:41:35 INFO - javascript benchmark 15:41:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.47299222636, 3037.6354837419512, 3045.0103716292206, 3069.831159286241, 3089.799163054401, 5105.872353191172, 5188.403333616635, 5252.65857719248, 5256.632035757494, 5303.0, 5251.86870328242, 5266.631335806495, 5300.496452836975, 5351.063563876325, 5391.32608423947, 4777.044591081798, 4785.808567657289, 4806.086843499741, 4814.109389762888, 4902.3872015998, 4877.0489754497885, 4898.314236006961, 4913.410390753114, 4916.866144788761, 4949.331840201563, 4706.670533062687, 4752.738599377033, 4762.785674644632, 4769.332293478881, 4771.045790841846, 4747.311639812242, 4792.688475249098, 4821.035792841446, 4860.392450943632, 4871.853844384674, 4759.4764575896625, 4761.285807128958, 4767.809287628491, 4787.8563643090765, 4796.112719146969, 5274.7626356814035, 5282.947170528284, 5301.6818990860675, 5306.51853172128, 5318.042752304584, 5509.201165830972, 5551.944480555183, 5564.10974244123, 5611.887762244733, 5613.410591887834, 5631.831045068655, 5646.915296270559, 5648.548116150698, 5652.858678533028, 5716.628419152742, 5288.021715982555, 5288.312519372495, 5290.074237008508, 5290.65610735301, 5313.8937221255355, 5580.19087232349, 5613.663180209201, 5631.915521267184, 5678.4037676044245, 5724.856878577985, 5425.050616142159, 5475.4524547544925, 5478.506934375846, 5529.419410961871, 5546.833594992157, 5508.173773933861, 5546.63946843462, 5556.472135147154, 5557.666540007613, 5567.916481252784, 5423.511883930465, 5468.699221542854, 5473.644213126214, 5597.524210442077, 5607.859803504945, 5522.392536820947, 5560.944390556124, 5572.665640061609, 5578.832635020955, 5665.178549110356, 4336.176126535948, 4347.543507931685, 4348.108637729258, 4393.165298593257, 4395.648348132142, 3836.7889766062576, 3871.1483473636317, 3876.573576906538, 3883.3204189266767, 3928.7642741435607, 5247.10799164143, 5281.867953301198, 5286.788528458896, 5331.120365139786, 5331.680099193984, 5591.860203494945, 5694.003549378842, 5706.28671416073, 5710.71446427677, 5729.942700573024, 5222.4255331913455, 5257.132573125468, 5318.787248510093, 5321.361436627552, 5325.227841962894, 4863.829765958245, 4870.512948705101, 4882.829100981448, 4885.975570122127, 4937.7777999990085, 5653.378128405872, 5718.857028574319, 5734.54123670097, 5772.0, 5782.884342313214, 5613.663180209201, 5613.887722245614, 5616.971915140562, 5623.8875222496135, 5676.347220069745, 5796.565257605612, 5800.303963524404, 5810.5351571875, 5813.215215945793, 5815.302163740378, 5261.947380526299, 5311.654742441729, 5421.674699518042, 5474.753636086465, 5485.588580856372, 5656.519195868397, 5656.971715141398, 5663.915041274467, 5667.801626943037, 5680.40355762639, 5488.917666235089, 5495.313085864267, 5496.862578435571, 5499.615026948075, 5500.4499550044675, 5369.436209197978, 5420.4037555868035, 5445.918311225256, 5498.395176530658, 5578.888422231614, 5475.2334673145, 5500.22996780443, 5529.972350138223, 5586.86032849182, 5599.692016939108, 5561.749721262634, 5564.972175139098, 5566.888662226814, 5567.220589117445, 5580.2745643067765, 5268.420473747808, 5321.574274058144, 5382.892342153214, 5406.756695948613, 5531.612787105025], "value": 5184.507284140193, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9245451864, 588.920495733076, 616.8735409241106, 623.1991890420809, 624.4036944717795, 43608.345874811865, 44719.55280447195, 44936.775316123414, 44939.32591011129, 49204.50795492044, 46861.297080543736, 47422.52577474233, 47458.28812567814, 47513.0, 47598.28602570964, 9066.682666106688, 9224.953875230649, 9226.86159707605, 9227.0, 9227.0, 8957.238634716057, 8970.910290897105, 9060.637574497012, 9062.320325975545, 9068.77328066797, 9077.409968352069, 9110.59002344896, 9112.179903808656, 9113.225375843029, 9114.088591140899, 9062.773430664252, 9088.318376121751, 9092.63629454821, 9098.499582522958, 9101.36290459668, 9022.0, 9077.228435582983, 9095.681651142244, 9095.727128186165, 9101.453912765255, 44241.77879110616, 44450.55549444529, 44544.77727611374, 44666.776666116784, 44703.32945005828, 3417.9829100854586, 3506.2286297014616, 3566.857325706969, 3865.3042452358563, 4223.66210703143, 32232.516512252336, 32457.188570285933, 32819.6718032819, 32858.50712239318, 32944.17639559006, 4345.50026746925, 4424.60178583929, 4426.756528390937, 4479.7984090716, 4572.177008138534, 328605.0, 328848.0, 329344.0, 331702.0, 338157.0, 58576.12135817966, 58856.0, 58878.116828247614, 58897.0, 59093.0, 61914.69042654758, 61984.38015619786, 62355.0, 62425.68787156126, 62552.68723656353, 16410.343586256655, 16607.252673629715, 16653.0, 16748.330066797436, 16772.0, 13170.407331670098, 13241.801372979413, 13245.801312980313, 13247.602571922858, 13255.0, 16527.0, 17586.27412751, 17777.644447110986, 17853.196606152753, 17996.820031799776, 5544.584156188302, 5596.916046259309, 5721.082248053523, 5778.797742079007, 5838.4453476919625, 954.9713508594754, 984.8276551603441, 1027.6608719122821, 1036.9533370998324, 1086.4839201379282, 31673.0, 31795.019233057286, 32004.544457953853, 32193.678063219537, 32196.35607287841, 1119.1869171941344, 1139.9430028498707, 1149.597640825721, 1207.209277922962, 1209.5766481731323, 15400.753254278185, 16419.42532011374, 16445.91777041107, 16472.670546589, 16646.16769161537, 550750.0, 556592.0, 556731.0, 556749.0, 556858.0, 58028.419715803146, 58073.22524035924, 58186.709066454394, 58313.70843145757, 58391.70804145952, 1217.9330136842382, 1275.4643049919057, 1327.289899903547, 1345.6232254968625, 1345.7013981507891, 30486.390272194876, 33460.66539334576, 33589.0, 33658.49512257367, 33901.66098338985, 50894.745526272134, 51324.23013654873, 51399.97200056053, 51426.0, 51477.48522514877, 407019.0, 409712.0, 411112.0, 411636.0, 412143.0, 27806.86096569585, 28561.714382855906, 28649.713502864706, 28758.42483150367, 30538.389232214788, 47866.76066619784, 48105.518944811505, 48118.75940620274, 48228.51771482381, 48593.75703121462, 39794.60205398025, 41023.7948810254, 41623.7918810404, 41784.3732344009, 42883.7855810719, 40763.59236407598, 40826.59173408228, 41130.79434602927, 42124.368134478624, 42285.57714422816, 33450.33099337951, 39962.40056399098, 41157.382639259835, 41242.0, 44385.33421998608, 31297.687023129478, 34792.652073478945, 35083.47374789431, 35715.28569428545, 36240.637593623724, 26439.735602643726, 26767.196984090508, 26865.597016044383, 27065.0, 27280.181594552196], "value": 20111.192899798258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.4699787791788, 385.88809245318856, 392.6171982317241, 392.7388286789284, 417.90388210711535, 14389.424423023092, 16390.26243819028, 17903.731444028333, 19454.22183112674, 19477.318293859717, 14844.55466336009, 16710.24803883825, 18128.093595320213, 18271.90864045678, 18651.440456786317, 5172.27588137661, 5421.078416669156, 5440.292761940942, 5463.699496527689, 5482.095454250064, 5425.593080518957, 5496.725163741817, 5504.394516603171, 5507.146392309199, 5604.187392828037, 5937.1984782054515, 5958.5828991970575, 5989.520838332945, 5998.790042348519, 5999.640021598696, 5680.147977803321, 5969.761209551591, 5974.61165024272, 5974.701264936779, 5978.8804223915495, 5887.587868849182, 5888.087346461305, 5888.499477544414, 5902.409759024106, 5905.586608937376, 15134.470293539784, 21529.138834446603, 22609.321720348416, 22811.31566053021, 22864.08543658268, 2137.7114089597862, 2375.3705268103968, 2378.5718570657273, 2385.976140238593, 2463.6058230683007, 10153.847692284622, 10285.897141028643, 10390.688279351632, 10951.671449856518, 11058.557657693682, 1879.2670858365248, 1905.8665893387467, 1941.7766956799867, 1944.8346890514324, 1957.559549101455, 80292.59853700752, 81806.0, 83408.0, 86900.56549717337, 87958.0, 11094.889051109385, 11142.66572002825, 11282.943585282184, 11332.263402878787, 11697.649070527897, 16051.518454446385, 16072.11603361803, 16072.276747546388, 16085.517434476984, 16099.356025759073, 7346.816329591803, 7677.0, 7790.519801237747, 8120.75637730869, 8266.13205613414, 7691.730789422343, 7701.152873183945, 7720.0, 7865.921340786519, 8032.919670803334, 4770.308305295713, 4901.289313049588, 4926.261060840902, 5020.949790502122, 5030.119729047402, 1902.8287454129195, 1979.435860779671, 2068.979310206909, 2093.309207961369, 2109.261758384553, 951.8102372034956, 955.441066975827, 963.6145541783203, 992.7270000749852, 1003.1924300937669, 19287.0, 19453.805461945198, 19548.511287217934, 19574.510637234183, 20134.19463221484, 980.2892902645667, 1001.4692213127055, 1014.2697257974394, 1018.8267994440963, 1039.4698703661188, 10142.239332050125, 10856.72858178536, 10941.890581094247, 10970.0, 11071.50178241965, 450580.0, 453364.0, 458192.0, 467228.0, 468493.0, 91286.0, 94584.0, 96539.0, 96893.0, 96987.51506242565, 964.1033838530234, 986.3342243985281, 998.5406712912142, 1001.5092604623682, 1018.2363227579316, 16430.67138657244, 16709.665806684043, 16778.916105419394, 17272.91363543174, 17655.823441765417, 42057.0, 42403.0, 42784.0, 43720.34419483646, 44590.55409445864, 41244.7636146018, 49143.754281228365, 54132.0, 59208.40791592029, 60389.094163586706, 8404.873926891223, 8695.695650652196, 8752.606132723915, 8821.823563528822, 9073.909260907307, 12972.675683107998, 13176.73646527045, 13219.801702974271, 13399.866001340251, 13757.587272381845, 11413.942930285295, 11494.770104598028, 11514.82727759101, 11938.880611194125, 12023.338716370683, 5479.0, 9359.549269863182, 11102.666919992413, 11293.103879161676, 11687.123465739933, 11383.203175777617, 11472.942635287103, 11585.246958947642, 12002.459889304828, 12308.50765969387, 7527.435442341955, 8602.673388177223, 8701.260392866678, 8710.82578348442, 9074.137956894348, 9986.750331241778, 11426.82859757121, 11491.367974761133, 11547.422628868691, 11875.94062029719], "value": 9123.757780364864, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.9412823487062, 1500.5648361975027, 1609.64587790686, 1712.537614843992, 1715.7683712698781, 7735.30382265596, 8019.117897031322, 8392.28665563427, 9081.954590227047, 9085.136911993359, 8295.709650162245, 8606.827863442728, 8614.095519970391, 8854.247388971946, 8865.689700860472, 2357.3752955466816, 2381.666566680666, 2385.3440303916477, 2400.855948643078, 2403.2189538400003, 1984.9603007939832, 2060.8866512341815, 2306.9884650576723, 2336.5560543496767, 2364.527094581082, 2105.52625659227, 2135.8184554312825, 2220.478971904243, 2283.600369935263, 2299.3217000984664, 2300.7469178390365, 2301.286601153631, 2302.781235782598, 2304.0553373117027, 2309.1340747219792, 2247.449374903143, 2271.5456908618344, 2274.5450909817937, 2281.190177486985, 2282.281081459335, 8743.868841967376, 8750.693725719633, 8846.292296616255, 8866.778330541789, 8868.113188681145, 5243.580513558906, 5369.785208591652, 5407.621466497347, 5409.134538473864, 5413.188021796723, 3414.470757032664, 3482.407990641597, 3619.3666108431185, 3628.89113326598, 3639.1448009717697, 1214.9392530373445, 1218.0986070307997, 1224.7550489901967, 1253.642711827125, 1259.8551166615864, 12180.878191218064, 12186.329751863645, 12291.078169137261, 12337.136400451973, 12338.444769985283, 4344.630706389929, 4512.72923624577, 4668.836590719308, 4702.57676809082, 4710.199266124699, 10352.792944141074, 10361.481925903674, 10367.896321036693, 10370.377777333384, 10380.273380863418, 5397.055515284809, 5404.54061404785, 5438.864028399243, 5449.128139497661, 5453.15476101205, 4812.51874812516, 4953.8018479261145, 4996.375453068366, 5024.2463630454995, 5025.070361983045, 3675.9081022974638, 3761.3417651910804, 3784.413415920537, 3800.5819359870393, 3874.3219936511, 1140.378493720924, 1149.6665966869682, 1159.750653609461, 1162.686074759827, 1173.8650055243586, 760.4752720622753, 830.2735106781566, 918.554501066982, 928.967486137982, 944.900785417535, 5571.442855714477, 5915.0, 5956.76172953077, 6056.06131049688, 6157.415045570664, 463.1200718634621, 463.7982477622245, 473.49336210254694, 474.1228726855359, 628.3088602537173, 3684.705223582107, 3743.513343265358, 3779.905502362463, 3969.64273215412, 4336.978315108404, 10832.620858269922, 11008.889911100787, 11149.052330551995, 11151.721206969729, 11167.83248251277, 11063.446827658585, 11077.390743509022, 11081.944590277159, 11092.500837462334, 11100.278481898651, 7725.884111738328, 8041.316488098577, 8044.919550804534, 8242.917570824215, 8247.587620618946, 5798.420157984167, 5842.037202824926, 5911.467967882912, 5939.198208241832, 6012.278526576839, 9944.204463643036, 10109.292349535463, 10120.797584048425, 10122.949385253027, 10128.797424051625, 9640.228781697308, 10025.949870250603, 10026.598936042477, 10134.594616215269, 10158.339707918962, 7717.729879454192, 7905.960470197612, 7912.3889116590235, 7913.366930645419, 7917.604119793872, 8068.139366921431, 8257.339412846837, 8270.545120018456, 8320.500769953822, 8341.24928756415, 7532.924670753222, 7610.429217808576, 7678.692852285846, 7680.769576912701, 7755.7673269802, 7393.297636724503, 7456.7390141344795, 7459.0, 7616.314531692175, 7739.032620922385, 6417.935820641734, 6506.479481641552, 6622.039804228263, 6628.635425051669, 6642.070110184482, 4664.067186562769, 4692.906141877075, 4729.408823897013, 4805.879853003703, 4914.459409465027, 4822.614190864792, 4828.565429111397, 4940.728259945594, 4975.950240497548, 5034.647574669738], "value": 4508.9485815207745, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.1274790925911, 334.22960077022464, 339.7519810538307, 342.89884484077197, 346.69664043961535, 5216.217567364897, 5276.894462110756, 5282.498162674539, 5312.150055991042, 5317.654352467087, 4964.602831773458, 5097.464766199551, 5125.513076257759, 5177.430482646906, 5235.450277720832, 4166.208420400114, 4167.395727619493, 4172.895677608054, 4176.644985176248, 4182.16356728654, 4169.812358443862, 4181.289180839264, 4192.958070419302, 4194.559571245006, 4197.0, 3892.4355968384566, 3966.7619942803526, 4036.677065834741, 4148.274052040896, 4161.167766446708, 4097.487814023247, 4106.767969609105, 4140.047789008515, 4149.6265336119595, 4149.730267532601, 3697.149655579205, 3701.68535674468, 3711.0722319420147, 3711.981440092782, 3714.0, 4940.55535001848, 5078.511529350629, 5112.36095488064, 5123.129068058439, 5130.53825155734, 4720.787564559569, 4748.620110391161, 4754.643401744848, 4758.643101767381, 4769.9012434528695, 5462.562994960394, 5465.508104270635, 5480.780768769284, 5483.972580137074, 5485.945140548623, 3925.7448265862913, 4073.5111786585503, 4097.057676734338, 4109.486314210723, 4122.793860307002, 5697.31632204134, 5702.914456283159, 5703.0, 5710.800121995751, 5713.885722285572, 4190.937135942963, 4193.266178418765, 4194.224068547329, 4195.091233488755, 4209.726367786146, 3926.4895563577124, 4109.712320137562, 4226.894327641833, 4228.429162063144, 4228.70399072062, 4704.647151463654, 4711.95288047122, 4713.34013238147, 4722.574968252874, 4761.000569641174, 5485.6560142765275, 5485.6982865942755, 5521.475459831309, 5521.613487055867, 5538.0, 1369.9178049317072, 1417.6810217700934, 1431.914085154894, 1434.2541878223265, 1441.1641248076091, 933.659214386744, 946.1957336264257, 969.2682025071167, 1000.6497725796058, 1001.1490233301636, 5229.686218826807, 5267.340787651954, 5287.603429742785, 5311.707856067954, 5322.627416080914, 5607.046802043581, 5635.774569017193, 5639.971800140973, 5654.151877218368, 5655.349634791969, 5215.55667768244, 5309.203619457112, 5328.760205790749, 5334.199870019528, 5346.679199248058, 2988.8804447821844, 2999.4301082794636, 3003.7296643302207, 3011.382666553351, 3015.638123425203, 5636.60543761941, 5796.246487956623, 5812.564057695689, 5819.854503637443, 5839.766409343663, 5717.599768016199, 5721.685307308055, 5723.427657234243, 5724.395400092948, 5736.139579063174, 5820.592558520948, 5838.649681019152, 5845.626277824623, 5849.532037436995, 5853.824385268364, 5320.760565774472, 5534.418886016911, 5566.554675625859, 5601.507329238612, 5620.3536593290655, 5519.834404967857, 5543.3967920851765, 5544.0, 5546.694931778791, 5551.0301988435995, 5650.491455769001, 5789.1605717171615, 5808.664007278265, 5832.096025116114, 5847.239858818326, 4112.77379744105, 4166.854160104382, 4171.833126674899, 4172.7913604320265, 4176.164767046542, 5723.370429252695, 5727.513161381329, 5731.08008817051, 5735.569832262514, 5754.935336962675, 5294.9205761912835, 5543.52880005204, 5549.0, 5574.358948720949, 5603.747831347518, 5439.619226654097, 5549.750261238335, 5553.916691249554, 5568.805091821767, 5576.525995290446, 5276.287701160294, 5469.097598896296, 5553.527950124285, 5570.192322113352, 5582.302212223472, 5407.134858422633, 5574.386817450159, 5585.301837270341, 5595.300587426572, 5599.160125980972, 5493.368262649687, 5497.092979658471, 5504.972475137599, 5506.146547285177, 5508.438576062151], "value": 4237.588693969257, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [689.1970853955143, 733.2154594583794, 773.2151865856155, 774.2760518914813, 779.6941810976308, 15556.611084722888, 16717.331306747714, 16803.24385402657, 16822.411215607455, 16834.410795622156, 15200.087994720325, 15356.0, 15376.692466150671, 15394.69210615787, 15409.383624655, 629.7103332467059, 658.1444122640572, 764.1021799385727, 776.8562815879052, 792.5165648954162, 792.3542313014904, 794.1224946434194, 794.630496818979, 794.9284564389204, 794.9682012719484, 833.649867055835, 834.1366685480529, 834.6160766047595, 835.0605568735173, 835.1481488881337, 674.5682763031639, 688.8863337549299, 808.8099296665279, 824.5094168969454, 830.0288662265104, 613.3529126771255, 613.677819144948, 613.7360934798035, 614.023702313324, 614.2291424262567, 15406.922965385102, 15437.382504699799, 15451.922740386226, 15452.072875627386, 15458.0, 14558.344874480674, 14724.48464303755, 14761.26193690322, 14778.556643300719, 15008.099514029193, 13275.46898124074, 13357.53248636293, 13375.866241337559, 13736.733438982556, 13907.860921390758, 3764.642358975893, 4351.8476853309985, 4369.060651959844, 4407.449068866392, 4448.3549885266775, 67484.66257668729, 78561.25035623783, 78866.0, 79014.0, 79103.60448197722, 11019.449027548591, 11140.554377824796, 11207.215494915277, 11266.718332041764, 11306.434678266054, 20227.29204477836, 20289.695654565192, 20346.796532034492, 20378.69431958522, 20475.38573842787, 8477.23704866565, 8786.428882122642, 8844.55777211137, 9035.503047332328, 9251.583678734338, 4792.209285467929, 4809.470958194595, 4886.780094895738, 4902.48523904992, 4913.828016019494, 3642.4354225095153, 3721.813909304524, 3750.5311836020496, 3770.698344132463, 3778.131029863147, 593.5577994394117, 642.0625886206097, 651.6839332923528, 657.4773055420952, 665.5041993714714, 600.69664819266, 643.9310744164665, 704.6793708862456, 705.8306006558491, 790.3124281874806, 9815.0, 9883.084490075446, 10352.482375881176, 10475.319104258198, 10493.265471416928, 601.8856417280703, 700.7911352916179, 720.2977097330062, 730.2113717185428, 746.4471507444553, 4571.428571428572, 4852.490488498657, 4950.975245123824, 5028.84913452597, 5032.798688052437, 113996.0, 120829.0, 121547.39226303989, 124723.0, 126955.36522317515, 62434.37565624376, 87665.0, 98665.0, 100468.0, 101170.49414752879, 23207.3037808866, 71285.0, 73777.26222737704, 74428.0, 76023.0, 9296.39573427725, 10005.240697761532, 10175.898241017496, 10530.21023423231, 10589.152867770406, 49231.753841230566, 50029.0, 51080.0, 51340.0, 53448.73275633597, 69100.65449672719, 73459.63270183615, 74341.2565874356, 75013.24986750062, 75476.0, 12687.429065692251, 12962.870371296543, 13004.934975325063, 13571.457141714222, 13898.525368657836, 14682.894815345095, 15166.620834479227, 15498.690026199187, 15715.371385144466, 15923.44267950616, 14096.788548171991, 14658.413663453342, 14941.103533788008, 15233.3906643733, 15236.31436585334, 13747.931260343634, 13983.440662373798, 14013.0, 14673.339699713326, 15091.0, 13696.178229306273, 13699.383527741475, 13738.313084345542, 13927.0, 14068.929655352067, 11012.559497620005, 11046.502907369348, 11210.383428911487, 11279.266847654877, 11537.596184133516, 10791.946040269748, 12054.698632534257, 12134.453949572115, 12234.816477752664, 12400.62798116058], "value": 7605.071328363045, "unit": "score"}], "name": "dromaeo_css", "value": 7190.799090436699, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 110.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 124.0, 166.0, 143.0, 123.0, 121.0, 121.0, 151.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 159.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 110.0, 77.0, 77.0, 77.0, 77.0, 101.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 83.0, 83.0, 82.0, 101.0, 82.0, 83.0, 117.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 63.0, 62.0, 62.0, 63.0, 63.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 86.0, 79.0, 78.0, 78.0, 87.0, 78.0, 81.0, 78.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 133.0, 140.0, 133.0, 141.0, 133.0, 129.0, 190.0, 131.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 165.0, 165.0, 165.0, 167.0, 163.0, 167.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 73.0, 75.0, 66.0, 65.0, 66.0, 64.0, 63.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1505.8000000000002, "alertThreshold": 2.0}]} 15:41:35 INFO - Return code: 0 15:41:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:41:35 INFO - # TBPL SUCCESS # 15:41:35 INFO - Running post-action listener: _resource_record_post_action 15:41:35 INFO - [mozharness: 2016-10-09 22:41:35.918300Z] Finished run-tests step (success) 15:41:35 INFO - Running post-run listener: _resource_record_post_run 15:41:35 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409804800; Read time: 12; Write time: 347904 15:41:35 INFO - TinderboxPrint: CPU usage
13.0% 15:41:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:41:35 INFO - TinderboxPrint: I/O write bytes / time
409,804,800 / 347,904 15:41:35 INFO - TinderboxPrint: CPU idle
8,310.2 (86.9%) 15:41:35 INFO - TinderboxPrint: CPU user
1,194.9 (12.5%) 15:41:35 INFO - TinderboxPrint: Swap in / out
0 / 0 15:41:35 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120893440; Read time: 0; Write time: 92700 15:41:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288911360; Read time: 12; Write time: 255204 15:41:36 INFO - Running post-run listener: _upload_blobber_files 15:41:36 INFO - Blob upload gear active. 15:41:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:41:36 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 15:41:36 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:41:36 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:41:36 INFO - (blobuploader) - INFO - Open directory for files ... 15:41:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:41:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:40 INFO - (blobuploader) - INFO - Done attempting. 15:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:41:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:40 INFO - (blobuploader) - INFO - Done attempting. 15:41:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:41:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:41:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:41 INFO - (blobuploader) - INFO - Done attempting. 15:41:41 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:41 INFO - Return code: 0 15:41:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238e9d290b456cf00750d427f8d8466c8acc93422a45fc9a30330fcd3a1425abde9929c55648d5940daa7006266d58c2923f7090a144ba7632957dce87d4b790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72d896b9bfa1c6d7cf1f3544331b65fd3a35e14139cda5548c8498964f82ede4193047d812dc24ab86b93891b35f3afa1da5fe6e79fd20616b4ecb32682fd36b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8accbbd370015da5bcdae5089705e439b42d77dfc94fb912904fab725f24bb6a458cf280ba47f248dd5c20b642b3da7a3370682762122805f7575b3a3ec1df97"} 15:41:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:41 INFO - Contents: 15:41:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238e9d290b456cf00750d427f8d8466c8acc93422a45fc9a30330fcd3a1425abde9929c55648d5940daa7006266d58c2923f7090a144ba7632957dce87d4b790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72d896b9bfa1c6d7cf1f3544331b65fd3a35e14139cda5548c8498964f82ede4193047d812dc24ab86b93891b35f3afa1da5fe6e79fd20616b4ecb32682fd36b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8accbbd370015da5bcdae5089705e439b42d77dfc94fb912904fab725f24bb6a458cf280ba47f248dd5c20b642b3da7a3370682762122805f7575b3a3ec1df97"} 15:41:41 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:41 INFO - Copying logs to upload dir... 15:41:41 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.701720 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-09 15:41:41.081339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 15:41:41.084599) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238e9d290b456cf00750d427f8d8466c8acc93422a45fc9a30330fcd3a1425abde9929c55648d5940daa7006266d58c2923f7090a144ba7632957dce87d4b790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72d896b9bfa1c6d7cf1f3544331b65fd3a35e14139cda5548c8498964f82ede4193047d812dc24ab86b93891b35f3afa1da5fe6e79fd20616b4ecb32682fd36b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8accbbd370015da5bcdae5089705e439b42d77dfc94fb912904fab725f24bb6a458cf280ba47f248dd5c20b642b3da7a3370682762122805f7575b3a3ec1df97"} build_url:https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011427 build_url: 'https://queue.taskcluster.net/v1/task/HELIGXcITlumzLj1y54Upg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/238e9d290b456cf00750d427f8d8466c8acc93422a45fc9a30330fcd3a1425abde9929c55648d5940daa7006266d58c2923f7090a144ba7632957dce87d4b790", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/72d896b9bfa1c6d7cf1f3544331b65fd3a35e14139cda5548c8498964f82ede4193047d812dc24ab86b93891b35f3afa1da5fe6e79fd20616b4ecb32682fd36b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8accbbd370015da5bcdae5089705e439b42d77dfc94fb912904fab725f24bb6a458cf280ba47f248dd5c20b642b3da7a3370682762122805f7575b3a3ec1df97"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-09 15:41:41.110592) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:41:41.110917) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1476050168.637996-818800524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004511 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-09 15:41:41.195166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 15:41:41.195521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-09 15:41:41.195845) ========= ========= Total master_lag: 0.16 =========