builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1482440886.59 results: success (0) buildid: 20161222112653 builduid: 55683df77ac649eaad910edd58f4e3ec revision: 3f796290f90ecb3a66af13f2ea0435859a38b57a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.594762) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.595230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.595522) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.611463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.611801) ========= 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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-22 13:08:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2016-12-22 13:08:06 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.075920 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.701166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.701456) ========= 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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018468 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:06.751433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 13:08:06.751852) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f796290f90ecb3a66af13f2ea0435859a38b57a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3f796290f90ecb3a66af13f2ea0435859a38b57a --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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-22 13:08:06,879 truncating revision to first 12 chars 2016-12-22 13:08:06,879 Setting DEBUG logging. 2016-12-22 13:08:06,880 attempt 1/10 2016-12-22 13:08:06,880 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3f796290f90e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-22 13:08:08,142 unpacking tar archive at: mozilla-aurora-3f796290f90e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.600811 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-22 13:08:08.366411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:08.366731) ========= script_repo_revision: 3f796290f90ecb3a66af13f2ea0435859a38b57a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:08.367247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:08.367528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-22 13:08:08.376376) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-22 13:08:08.376649) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:08:08 INFO - MultiFileLogger online at 20161222 13:08:08 in /builds/slave/test 13:08:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:08:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:08:08 INFO - {'append_to_log': False, 13:08:08 INFO - 'base_work_dir': '/builds/slave/test', 13:08:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:08:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:08:08 INFO - 'branch': 'Mozilla-Aurora', 13:08:08 INFO - 'buildbot_json_path': 'buildprops.json', 13:08:08 INFO - 'config_files': ('talos/linux_config.py',), 13:08:08 INFO - 'default_actions': ('clobber', 13:08:08 INFO - 'read-buildbot-config', 13:08:08 INFO - 'download-and-extract', 13:08:08 INFO - 'populate-webroot', 13:08:08 INFO - 'create-virtualenv', 13:08:08 INFO - 'install', 13:08:08 INFO - 'run-tests'), 13:08:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:08:08 INFO - 'download_minidump_stackwalk': True, 13:08:08 INFO - 'download_symbols': 'ondemand', 13:08:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:08:08 INFO - 'tooltool.py': '/tools/tooltool.py', 13:08:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:08:08 INFO - '/tools/misc-python/virtualenv.py')}, 13:08:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:08:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:08:08 INFO - 'installer_path': 'installer.exe', 13:08:08 INFO - 'log_level': 'info', 13:08:08 INFO - 'log_name': 'talos', 13:08:08 INFO - 'log_to_console': True, 13:08:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:08:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:08:08 INFO - 'opt_config_files': (), 13:08:08 INFO - 'pip_index': False, 13:08:08 INFO - 'sps_profile': False, 13:08:08 INFO - 'sps_profile_interval': 0, 13:08:08 INFO - 'suite': 'dromaeojs', 13:08:08 INFO - 'system_bits': '32', 13:08:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:08:08 INFO - 'title': 'talos-linux64-ix-020', 13:08:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:08:08 INFO - 'use_talos_json': True, 13:08:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:08:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:08:08 INFO - 'work_dir': 'build'} 13:08:08 INFO - [mozharness: 2016-12-22 21:08:08.594778Z] Running clobber step. 13:08:08 INFO - Running pre-action listener: _resource_record_pre_action 13:08:08 INFO - Running main action method: clobber 13:08:08 INFO - rmtree: /builds/slave/test/build 13:08:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:08:09 INFO - Running post-action listener: _resource_record_post_action 13:08:09 INFO - [mozharness: 2016-12-22 21:08:09.047261Z] Finished clobber step (success) 13:08:09 INFO - [mozharness: 2016-12-22 21:08:09.047361Z] Running read-buildbot-config step. 13:08:09 INFO - Running pre-action listener: _resource_record_pre_action 13:08:09 INFO - Running main action method: read_buildbot_config 13:08:09 INFO - Using buildbot properties: 13:08:09 INFO - { 13:08:09 INFO - "project": "", 13:08:09 INFO - "product": "firefox", 13:08:09 INFO - "script_repo_revision": "production", 13:08:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:08:09 INFO - "repository": "", 13:08:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:08:09 INFO - "buildid": "20161222112653", 13:08:09 INFO - "pgo_build": "True", 13:08:09 INFO - "basedir": "/builds/slave/test", 13:08:09 INFO - "buildnumber": 986, 13:08:09 INFO - "slavename": "talos-linux64-ix-020", 13:08:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:08:09 INFO - "platform": "ubuntu64_hw", 13:08:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:08:09 INFO - "branch": "mozilla-aurora", 13:08:09 INFO - "repo_path": "releases/mozilla-aurora", 13:08:09 INFO - "revision": "3f796290f90ecb3a66af13f2ea0435859a38b57a", 13:08:09 INFO - "stage_platform": "linux64-pgo", 13:08:09 INFO - "builduid": "55683df77ac649eaad910edd58f4e3ec", 13:08:09 INFO - "slavebuilddir": "test" 13:08:09 INFO - } 13:08:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 13:08:09 INFO - Running post-action listener: _resource_record_post_action 13:08:09 INFO - [mozharness: 2016-12-22 21:08:09.049768Z] Finished read-buildbot-config step (success) 13:08:09 INFO - [mozharness: 2016-12-22 21:08:09.049856Z] Running download-and-extract step. 13:08:09 INFO - Running pre-action listener: _resource_record_pre_action 13:08:09 INFO - Running main action method: download_and_extract 13:08:09 INFO - mkdir: /builds/slave/test/build/tests 13:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:09 INFO - trying https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:08:09 INFO - Downloading https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:08:09 INFO - Downloaded 1361 bytes. 13:08:09 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:08:09 INFO - Using the following test package requirements: 13:08:09 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:08:09 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:08:09 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:08:09 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'jsshell-linux-x86_64.zip'], 13:08:09 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:08:09 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:08:09 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:08:09 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:08:09 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:08:09 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:08:09 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:08:09 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:08:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:08:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:08:09 INFO - Fetch https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:08:10 INFO - Http code: 200 13:08:10 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 13:08:10 INFO - x-amz-cf-id: r3zTGT86rmiD-4YurU6Zr-p9iDund2R3EvWYowFUaA9mvPN0xebZ9Q== 13:08:10 INFO - x-amz-version-id: H7H18q83SfTQEwyzzUS2qh5aJ.eIShlG 13:08:10 INFO - Expected file size: 21943876 13:08:10 INFO - Obtained file size: 21943876 13:08:14 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:08:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:08:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:08:14 INFO - Fetch https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:08:15 INFO - Http code: 200 13:08:15 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 13:08:15 INFO - x-amz-cf-id: Y3G2f5twbJBFgXBihyLA3Sw9o1Nz-v37fHYCNLoIFkdMunUrHHuSmg== 13:08:15 INFO - x-amz-version-id: H7H18q83SfTQEwyzzUS2qh5aJ.eIShlG 13:08:15 INFO - Expected file size: 21943876 13:08:15 INFO - Obtained file size: 21943876 13:08:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 13:08:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:08:19 INFO - Fetch https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 13:08:20 INFO - Http code: 200 13:08:20 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 13:08:20 INFO - x-amz-cf-id: 8vckNrG0gsXmAEkWhKfbSG9m1gdMUQyYxcDUc7nS7s-F5pPmG-pWuQ== 13:08:20 INFO - x-amz-version-id: qjynenuKlVMiK15pIpEYb1L1ga3TpzRy 13:08:20 INFO - Expected file size: 14409038 13:08:20 INFO - Obtained file size: 14409038 13:08:20 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')]} 13:08:20 INFO - trying https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:08:20 INFO - Downloading https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:08:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:08:21 INFO - Downloaded 63996587 bytes. 13:08:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:08:21 INFO - mkdir: /builds/slave/test/properties 13:08:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:08:21 INFO - Writing to file /builds/slave/test/properties/build_url 13:08:21 INFO - Contents: 13:08:21 INFO - build_url:https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:08:22 INFO - Running post-action listener: _resource_record_post_action 13:08:22 INFO - Running post-action listener: set_extra_try_arguments 13:08:22 INFO - [mozharness: 2016-12-22 21:08:22.605622Z] Finished download-and-extract step (success) 13:08:22 INFO - [mozharness: 2016-12-22 21:08:22.605848Z] Running populate-webroot step. 13:08:22 INFO - Running pre-action listener: _resource_record_pre_action 13:08:22 INFO - Running main action method: populate_webroot 13:08:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:08:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:08:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:08:22 INFO - '--tppagecycles', 13:08:22 INFO - '7'], 13:08:22 INFO - 'tests': ['tsvgm']}}, 13:08:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:08:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:08:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:08:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:08:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:08:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['damp', 'tps']}, 13:08:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'tests': ['damp', 'tps']}, 13:08:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['dromaeo_dom']}, 13:08:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:08:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['basic_compositor_video']}, 13:08:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:08:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'other-e10s': {'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['a11yr', 13:08:22 INFO - 'ts_paint', 13:08:22 INFO - 'tpaint', 13:08:22 INFO - 'sessionrestore', 13:08:22 INFO - 'sessionrestore_no_auto_restore', 13:08:22 INFO - 'tabpaint']}, 13:08:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['tsvgx', 13:08:22 INFO - 'tsvgr_opacity', 13:08:22 INFO - 'tart', 13:08:22 INFO - 'tscrollx', 13:08:22 INFO - 'cart']}, 13:08:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:08:22 INFO - 'tsvgr_opacity', 13:08:22 INFO - 'tart', 13:08:22 INFO - 'tscrollx', 13:08:22 INFO - 'cart']}, 13:08:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'talos_options': ['--disable-e10s'], 13:08:22 INFO - 'tests': ['tp5o']}, 13:08:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'tests': ['tp5o']}, 13:08:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'talos_options': ['--disable-e10s', 13:08:22 INFO - '--xperf_path', 13:08:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:22 INFO - 'tests': ['tp5n']}, 13:08:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:08:22 INFO - 'talos_options': ['--xperf_path', 13:08:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:08:22 INFO - 'tests': ['tp5n']}}, 13:08:22 INFO - 'talos.zip': {'path': '', 13:08:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:08:22 INFO - Running post-action listener: _resource_record_post_action 13:08:22 INFO - [mozharness: 2016-12-22 21:08:22.626877Z] Finished populate-webroot step (success) 13:08:22 INFO - [mozharness: 2016-12-22 21:08:22.626965Z] Running create-virtualenv step. 13:08:22 INFO - Running pre-action listener: _resource_record_pre_action 13:08:22 INFO - Running main action method: create_virtualenv 13:08:22 INFO - Creating virtualenv /builds/slave/test/build/venv 13:08:22 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 13:08:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:08:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:08:22 INFO - Using real prefix '/usr' 13:08:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:08:23 INFO - Installing distribute.............................................................................................................................................................................................done. 13:08:25 INFO - Installing pip.................done. 13:08:25 INFO - Return code: 0 13:08:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:08:25 INFO - Reading from file tmpfile_stdout 13:08:25 INFO - Output received: 13:08:25 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) 13:08:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:08:25 INFO - Using env: {'DISPLAY': ':0', 13:08:25 INFO - 'HOME': '/home/cltbld', 13:08:25 INFO - 'LANG': 'en_US.UTF-8', 13:08:25 INFO - 'LANGUAGE': 'en_US:en', 13:08:25 INFO - 'LOGNAME': 'cltbld', 13:08:25 INFO - 'MAIL': '/var/mail/cltbld', 13:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:25 INFO - 'MOZ_NO_REMOTE': '1', 13:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:25 INFO - 'NO_EM_RESTART': '1', 13:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:25 INFO - 'PWD': '/builds/slave/test', 13:08:25 INFO - 'SHELL': '/bin/bash', 13:08:25 INFO - 'SHLVL': '1', 13:08:25 INFO - 'TERM': 'linux', 13:08:25 INFO - 'TMOUT': '86400', 13:08:25 INFO - 'USER': 'cltbld', 13:08:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:25 INFO - '_': '/tools/buildbot/bin/python'} 13:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:25 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 13:08:25 INFO - Cleaning up... 13:08:25 INFO - Return code: 0 13:08:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:08:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:08:25 INFO - Using env: {'DISPLAY': ':0', 13:08:25 INFO - 'HOME': '/home/cltbld', 13:08:25 INFO - 'LANG': 'en_US.UTF-8', 13:08:25 INFO - 'LANGUAGE': 'en_US:en', 13:08:25 INFO - 'LOGNAME': 'cltbld', 13:08:25 INFO - 'MAIL': '/var/mail/cltbld', 13:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:25 INFO - 'MOZ_NO_REMOTE': '1', 13:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:25 INFO - 'NO_EM_RESTART': '1', 13:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:25 INFO - 'PWD': '/builds/slave/test', 13:08:25 INFO - 'SHELL': '/bin/bash', 13:08:25 INFO - 'SHLVL': '1', 13:08:25 INFO - 'TERM': 'linux', 13:08:25 INFO - 'TMOUT': '86400', 13:08:25 INFO - 'USER': 'cltbld', 13:08:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:25 INFO - '_': '/tools/buildbot/bin/python'} 13:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:25 INFO - Downloading/unpacking psutil>=3.1.1 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:08:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:27 INFO - Installing collected packages: psutil 13:08:27 INFO - Running setup.py install for psutil 13:08:27 INFO - building 'psutil._psutil_linux' extension 13:08:27 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 13:08:28 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 13:08:28 INFO - building 'psutil._psutil_posix' extension 13:08:28 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 13:08:28 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 13:08:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:08:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:08:28 INFO - Successfully installed psutil 13:08:28 INFO - Cleaning up... 13:08:28 INFO - Return code: 0 13:08:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:08:28 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')]} 13:08:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:28 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')]} 13:08:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:28 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:28 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 13:08:28 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 13:08:28 INFO - Using env: {'DISPLAY': ':0', 13:08:28 INFO - 'HOME': '/home/cltbld', 13:08:28 INFO - 'LANG': 'en_US.UTF-8', 13:08:28 INFO - 'LANGUAGE': 'en_US:en', 13:08:28 INFO - 'LOGNAME': 'cltbld', 13:08:28 INFO - 'MAIL': '/var/mail/cltbld', 13:08:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:28 INFO - 'MOZ_NO_REMOTE': '1', 13:08:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:28 INFO - 'NO_EM_RESTART': '1', 13:08:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:28 INFO - 'PWD': '/builds/slave/test', 13:08:28 INFO - 'SHELL': '/bin/bash', 13:08:28 INFO - 'SHLVL': '1', 13:08:28 INFO - 'TERM': 'linux', 13:08:28 INFO - 'TMOUT': '86400', 13:08:28 INFO - 'USER': 'cltbld', 13:08:28 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:28 INFO - '_': '/tools/buildbot/bin/python'} 13:08:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:08:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:08:30 INFO - Installing collected packages: mozsystemmonitor 13:08:30 INFO - Running setup.py install for mozsystemmonitor 13:08:30 INFO - Successfully installed mozsystemmonitor 13:08:30 INFO - Cleaning up... 13:08:30 INFO - Return code: 0 13:08:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:30 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:30 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 13:08:30 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 13:08:30 INFO - Using env: {'DISPLAY': ':0', 13:08:30 INFO - 'HOME': '/home/cltbld', 13:08:30 INFO - 'LANG': 'en_US.UTF-8', 13:08:30 INFO - 'LANGUAGE': 'en_US:en', 13:08:30 INFO - 'LOGNAME': 'cltbld', 13:08:30 INFO - 'MAIL': '/var/mail/cltbld', 13:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:30 INFO - 'MOZ_NO_REMOTE': '1', 13:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:30 INFO - 'NO_EM_RESTART': '1', 13:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:30 INFO - 'PWD': '/builds/slave/test', 13:08:30 INFO - 'SHELL': '/bin/bash', 13:08:30 INFO - 'SHLVL': '1', 13:08:30 INFO - 'TERM': 'linux', 13:08:30 INFO - 'TMOUT': '86400', 13:08:30 INFO - 'USER': 'cltbld', 13:08:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:30 INFO - '_': '/tools/buildbot/bin/python'} 13:08:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:31 INFO - Downloading/unpacking jsonschema==2.5.1 13:08:31 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 13:08:31 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 13:08:31 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 13:08:31 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 13:08:31 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 13:08:31 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 13:08:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:08:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:08:33 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 13:08:33 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 13:08:33 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 13:08:33 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 13:08:33 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 13:08:33 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 13:08:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:08:33 INFO - warning: no files found matching '*.txt' 13:08:33 INFO - no previously-included directories found matching 'build' 13:08:33 INFO - no previously-included directories found matching 'dist' 13:08:33 INFO - no previously-included directories found matching '.git*' 13:08:33 INFO - Installing collected packages: jsonschema, functools32 13:08:33 INFO - Running setup.py install for functools32 13:08:33 INFO - warning: no files found matching '*.txt' 13:08:33 INFO - no previously-included directories found matching 'build' 13:08:33 INFO - no previously-included directories found matching 'dist' 13:08:33 INFO - no previously-included directories found matching '.git*' 13:08:33 INFO - Successfully installed jsonschema functools32 13:08:33 INFO - Cleaning up... 13:08:33 INFO - Return code: 0 13:08:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:33 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:33 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 13:08:33 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 13:08:33 INFO - Using env: {'DISPLAY': ':0', 13:08:33 INFO - 'HOME': '/home/cltbld', 13:08:33 INFO - 'LANG': 'en_US.UTF-8', 13:08:33 INFO - 'LANGUAGE': 'en_US:en', 13:08:33 INFO - 'LOGNAME': 'cltbld', 13:08:33 INFO - 'MAIL': '/var/mail/cltbld', 13:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:33 INFO - 'MOZ_NO_REMOTE': '1', 13:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:33 INFO - 'NO_EM_RESTART': '1', 13:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:33 INFO - 'PWD': '/builds/slave/test', 13:08:33 INFO - 'SHELL': '/bin/bash', 13:08:33 INFO - 'SHLVL': '1', 13:08:33 INFO - 'TERM': 'linux', 13:08:33 INFO - 'TMOUT': '86400', 13:08:33 INFO - 'USER': 'cltbld', 13:08:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:33 INFO - '_': '/tools/buildbot/bin/python'} 13:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:08:33 INFO - Cleaning up... 13:08:33 INFO - Return code: 0 13:08:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:33 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:33 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 13:08:33 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 13:08:33 INFO - Using env: {'DISPLAY': ':0', 13:08:33 INFO - 'HOME': '/home/cltbld', 13:08:33 INFO - 'LANG': 'en_US.UTF-8', 13:08:33 INFO - 'LANGUAGE': 'en_US:en', 13:08:33 INFO - 'LOGNAME': 'cltbld', 13:08:33 INFO - 'MAIL': '/var/mail/cltbld', 13:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:33 INFO - 'MOZ_NO_REMOTE': '1', 13:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:33 INFO - 'NO_EM_RESTART': '1', 13:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:33 INFO - 'PWD': '/builds/slave/test', 13:08:33 INFO - 'SHELL': '/bin/bash', 13:08:33 INFO - 'SHLVL': '1', 13:08:33 INFO - 'TERM': 'linux', 13:08:33 INFO - 'TMOUT': '86400', 13:08:33 INFO - 'USER': 'cltbld', 13:08:33 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:33 INFO - '_': '/tools/buildbot/bin/python'} 13:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:34 INFO - Downloading/unpacking blobuploader==1.2.4 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08: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 13:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 13:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 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 13:08:36 INFO - Downloading docopt-0.6.1.tar.gz 13:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:08:36 INFO - Installing collected packages: blobuploader, requests, docopt 13:08:36 INFO - Running setup.py install for blobuploader 13:08:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:08:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:08:36 INFO - Running setup.py install for requests 13:08:37 INFO - Running setup.py install for docopt 13:08:37 INFO - Successfully installed blobuploader requests docopt 13:08:37 INFO - Cleaning up... 13:08:37 INFO - Return code: 0 13:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08: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')]} 13:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08: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')]} 13:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:37 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:37 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 13:08:37 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 13:08:37 INFO - Using env: {'DISPLAY': ':0', 13:08:37 INFO - 'HOME': '/home/cltbld', 13:08:37 INFO - 'LANG': 'en_US.UTF-8', 13:08:37 INFO - 'LANGUAGE': 'en_US:en', 13:08:37 INFO - 'LOGNAME': 'cltbld', 13:08:37 INFO - 'MAIL': '/var/mail/cltbld', 13:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:37 INFO - 'MOZ_NO_REMOTE': '1', 13:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:37 INFO - 'NO_EM_RESTART': '1', 13:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:37 INFO - 'PWD': '/builds/slave/test', 13:08:37 INFO - 'SHELL': '/bin/bash', 13:08:37 INFO - 'SHLVL': '1', 13:08:37 INFO - 'TERM': 'linux', 13:08:37 INFO - 'TMOUT': '86400', 13:08:37 INFO - 'USER': 'cltbld', 13:08:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:37 INFO - '_': '/tools/buildbot/bin/python'} 13:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:37 INFO - Running setup.py (path:/tmp/pip-9TvAmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:37 INFO - Running setup.py (path:/tmp/pip-YAtcwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:37 INFO - Running setup.py (path:/tmp/pip-TZ0VPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:37 INFO - Running setup.py (path:/tmp/pip-YZCGmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:37 INFO - Running setup.py (path:/tmp/pip-TdMAzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:38 INFO - Running setup.py (path:/tmp/pip-XHhOKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:38 INFO - Running setup.py (path:/tmp/pip-DQtHY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:38 INFO - Running setup.py (path:/tmp/pip-BNZw2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:38 INFO - Running setup.py (path:/tmp/pip-yinDrv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:38 INFO - Running setup.py (path:/tmp/pip-xB34_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:38 INFO - Running setup.py (path:/tmp/pip-Dshn8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:38 INFO - Running setup.py (path:/tmp/pip-fbJ9vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:38 INFO - Running setup.py (path:/tmp/pip-ShkET5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:38 INFO - Running setup.py (path:/tmp/pip-wlmliQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:38 INFO - Running setup.py (path:/tmp/pip-BpY0_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:38 INFO - Running setup.py (path:/tmp/pip-sVEXMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:38 INFO - Running setup.py (path:/tmp/pip-9e6iJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:08:38 INFO - Running setup.py install for manifestparser 13:08:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:08:38 INFO - Running setup.py install for mozcrash 13:08:39 INFO - Running setup.py install for mozdebug 13:08:39 INFO - Running setup.py install for mozdevice 13:08:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Running setup.py install for mozfile 13:08:39 INFO - Running setup.py install for mozhttpd 13:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Running setup.py install for mozinfo 13:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Running setup.py install for mozInstall 13:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Running setup.py install for mozleak 13:08:39 INFO - Running setup.py install for mozlog 13:08:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:08:39 INFO - Running setup.py install for moznetwork 13:08:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Running setup.py install for mozprocess 13:08:40 INFO - Running setup.py install for mozprofile 13:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Running setup.py install for mozrunner 13:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Running setup.py install for mozscreenshot 13:08:40 INFO - Running setup.py install for moztest 13:08:40 INFO - Running setup.py install for mozversion 13:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:08:40 INFO - Cleaning up... 13:08:40 INFO - Return code: 0 13:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:40 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')]} 13:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:40 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')]} 13:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:40 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:40 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 13:08:40 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 13:08:40 INFO - Using env: {'DISPLAY': ':0', 13:08:40 INFO - 'HOME': '/home/cltbld', 13:08:40 INFO - 'LANG': 'en_US.UTF-8', 13:08:40 INFO - 'LANGUAGE': 'en_US:en', 13:08:40 INFO - 'LOGNAME': 'cltbld', 13:08:40 INFO - 'MAIL': '/var/mail/cltbld', 13:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:40 INFO - 'MOZ_NO_REMOTE': '1', 13:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:40 INFO - 'NO_EM_RESTART': '1', 13:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:40 INFO - 'PWD': '/builds/slave/test', 13:08:40 INFO - 'SHELL': '/bin/bash', 13:08:40 INFO - 'SHLVL': '1', 13:08:40 INFO - 'TERM': 'linux', 13:08:40 INFO - 'TMOUT': '86400', 13:08:40 INFO - 'USER': 'cltbld', 13:08:40 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:40 INFO - '_': '/tools/buildbot/bin/python'} 13:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:08:40 INFO - Running setup.py (path:/tmp/pip-DEyu3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:08:40 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)) 13:08:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:08:40 INFO - Running setup.py (path:/tmp/pip-AzUtlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:08:41 INFO - Running setup.py (path:/tmp/pip-SdeQTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:08:41 INFO - Running setup.py (path:/tmp/pip-mQgB8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:08:41 INFO - Running setup.py (path:/tmp/pip-htoe9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:08:41 INFO - Running setup.py (path:/tmp/pip-Oz769L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:08:41 INFO - Running setup.py (path:/tmp/pip-bm62F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:08:41 INFO - Running setup.py (path:/tmp/pip-VtTS1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:08:41 INFO - Running setup.py (path:/tmp/pip-aQeS5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:08:41 INFO - Running setup.py (path:/tmp/pip-p9k4sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:08:41 INFO - Running setup.py (path:/tmp/pip-qulAUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:08:41 INFO - Running setup.py (path:/tmp/pip-cwLhC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:08:41 INFO - Running setup.py (path:/tmp/pip-Jy4XTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:08:41 INFO - Running setup.py (path:/tmp/pip-nDncPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:41 INFO - Running setup.py (path:/tmp/pip-M6swAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:08:41 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)) 13:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:08:41 INFO - Running setup.py (path:/tmp/pip-OGlLDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:08:42 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)) 13:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:08:42 INFO - Running setup.py (path:/tmp/pip-iwetLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:08:42 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)) 13:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:08:42 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)) 13:08:42 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)) 13:08:42 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)) 13:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:08:44 INFO - Downloading blessings-1.6.tar.gz 13:08:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:08:44 INFO - Installing collected packages: blessings 13:08:44 INFO - Running setup.py install for blessings 13:08:44 INFO - Successfully installed blessings 13:08:44 INFO - Cleaning up... 13:08:44 INFO - Return code: 0 13:08:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:08:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:44 INFO - Reading from file tmpfile_stdout 13:08:44 INFO - Current package versions: 13:08:44 INFO - argparse == 1.2.1 13:08:44 INFO - blessings == 1.6 13:08:44 INFO - blobuploader == 1.2.4 13:08:44 INFO - docopt == 0.6.1 13:08:44 INFO - functools32 == 3.2.3-2 13:08:44 INFO - jsonschema == 2.5.1 13:08:44 INFO - manifestparser == 1.1 13:08:44 INFO - mozInstall == 1.12 13:08:44 INFO - mozcrash == 1.0 13:08:44 INFO - mozdebug == 0.1 13:08:44 INFO - mozdevice == 0.48 13:08:44 INFO - mozfile == 1.2 13:08:44 INFO - mozhttpd == 0.7 13:08:44 INFO - mozinfo == 0.9 13:08:44 INFO - mozleak == 0.1 13:08:44 INFO - mozlog == 3.4 13:08:44 INFO - moznetwork == 0.27 13:08:44 INFO - mozprocess == 0.23 13:08:44 INFO - mozprofile == 0.28 13:08:44 INFO - mozrunner == 6.13 13:08:44 INFO - mozscreenshot == 0.1 13:08:44 INFO - mozsystemmonitor == 0.3 13:08:44 INFO - moztest == 0.7 13:08:44 INFO - mozversion == 1.4 13:08:44 INFO - psutil == 3.1.1 13:08:44 INFO - requests == 1.2.3 13:08:44 INFO - wsgiref == 0.1.2 13:08:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:44 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 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:44 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 13:08:44 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 13:08:44 INFO - Using env: {'DISPLAY': ':0', 13:08:44 INFO - 'HOME': '/home/cltbld', 13:08:44 INFO - 'LANG': 'en_US.UTF-8', 13:08:44 INFO - 'LANGUAGE': 'en_US:en', 13:08:44 INFO - 'LOGNAME': 'cltbld', 13:08:44 INFO - 'MAIL': '/var/mail/cltbld', 13:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:44 INFO - 'MOZ_NO_REMOTE': '1', 13:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:44 INFO - 'NO_EM_RESTART': '1', 13:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:44 INFO - 'PWD': '/builds/slave/test', 13:08:44 INFO - 'SHELL': '/bin/bash', 13:08:44 INFO - 'SHLVL': '1', 13:08:44 INFO - 'TERM': 'linux', 13:08:44 INFO - 'TMOUT': '86400', 13:08:44 INFO - 'USER': 'cltbld', 13:08:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:44 INFO - '_': '/tools/buildbot/bin/python'} 13:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 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)) 13:08:44 INFO - Cleaning up... 13:08:44 INFO - Return code: 0 13:08:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:08:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:08:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:08:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:08:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7d6b64f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2acc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b99ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', '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 13:08:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:08:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:08:44 INFO - Using env: {'DISPLAY': ':0', 13:08:44 INFO - 'HOME': '/home/cltbld', 13:08:44 INFO - 'LANG': 'en_US.UTF-8', 13:08:44 INFO - 'LANGUAGE': 'en_US:en', 13:08:44 INFO - 'LOGNAME': 'cltbld', 13:08:44 INFO - 'MAIL': '/var/mail/cltbld', 13:08:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:08:44 INFO - 'MOZ_NO_REMOTE': '1', 13:08:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:08:44 INFO - 'NO_EM_RESTART': '1', 13:08:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:08:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:08:44 INFO - 'PWD': '/builds/slave/test', 13:08:44 INFO - 'SHELL': '/bin/bash', 13:08:44 INFO - 'SHLVL': '1', 13:08:44 INFO - 'TERM': 'linux', 13:08:44 INFO - 'TMOUT': '86400', 13:08:44 INFO - 'USER': 'cltbld', 13:08:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:08:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:08:44 INFO - '_': '/tools/buildbot/bin/python'} 13:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:08:45 INFO - Cleaning up... 13:08:45 INFO - Return code: 0 13:08:45 INFO - Running post-action listener: _resource_record_post_action 13:08:45 INFO - Running post-action listener: _start_resource_monitoring 13:08:45 INFO - Starting resource monitoring. 13:08:45 INFO - [mozharness: 2016-12-22 21:08:45.109453Z] Finished create-virtualenv step (success) 13:08:45 INFO - [mozharness: 2016-12-22 21:08:45.109968Z] Running install step. 13:08:45 INFO - Running pre-action listener: _resource_record_pre_action 13:08:45 INFO - Running main action method: install 13:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:08:45 INFO - Reading from file tmpfile_stdout 13:08:45 INFO - Detecting whether we're running mozinstall >=1.0... 13:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:08:45 INFO - Reading from file tmpfile_stdout 13:08:45 INFO - Output received: 13:08:45 INFO - Usage: mozinstall [options] installer 13:08:45 INFO - Options: 13:08:45 INFO - -h, --help show this help message and exit 13:08:45 INFO - -d DEST, --destination=DEST 13:08:45 INFO - Directory to install application into. [default: 13:08:45 INFO - "/builds/slave/test"] 13:08:45 INFO - --app=APP Application being installed. [default: firefox] 13:08:45 INFO - mkdir: /builds/slave/test/build/application 13:08:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:09:01 INFO - Reading from file tmpfile_stdout 13:09:01 INFO - Output received: 13:09:01 INFO - /builds/slave/test/build/application/firefox/firefox 13:09:01 INFO - Running post-action listener: _resource_record_post_action 13:09:01 INFO - [mozharness: 2016-12-22 21:09:01.325208Z] Finished install step (success) 13:09:01 INFO - [mozharness: 2016-12-22 21:09:01.325452Z] Running run-tests step. 13:09:01 INFO - Running pre-action listener: _resource_record_pre_action 13:09:01 INFO - Running main action method: run_tests 13:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:09:01 INFO - Python 2.7.3 13:09:01 INFO - Return code: 0 13:09:01 INFO - grabbing minidump binary from tooltool 13:09: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')]} 13:09:01 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 0x2b96f60>, '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 0x2b97d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b981d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:09:01 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 13:09:01 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 13:09:01 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 13:09:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:09:01 INFO - Return code: 0 13:09:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:09:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:09:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:09:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:09:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 13:09:01 INFO - Using env: {'DISPLAY': ':0', 13:09:01 INFO - 'HOME': '/home/cltbld', 13:09:01 INFO - 'LANG': 'en_US.UTF-8', 13:09:01 INFO - 'LANGUAGE': 'en_US:en', 13:09:01 INFO - 'LOGNAME': 'cltbld', 13:09:01 INFO - 'MAIL': '/var/mail/cltbld', 13:09:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:09:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:09:01 INFO - 'MOZ_NO_REMOTE': '1', 13:09:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:09:01 INFO - 'NO_EM_RESTART': '1', 13:09:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:09:01 INFO - 'PWD': '/builds/slave/test', 13:09:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:09:01 INFO - 'SHELL': '/bin/bash', 13:09:01 INFO - 'SHLVL': '1', 13:09:01 INFO - 'TERM': 'linux', 13:09:01 INFO - 'TMOUT': '86400', 13:09:01 INFO - 'USER': 'cltbld', 13:09:01 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752', 13:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:09:01 INFO - '_': '/tools/buildbot/bin/python'} 13:09:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 13:09:01 INFO - mozversion application_buildid: 20161222112653 13:09:01 INFO - mozversion application_changeset: 3f796290f90ecb3a66af13f2ea0435859a38b57a 13:09:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:09:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:09:01 INFO - mozversion application_name: Firefox 13:09:01 INFO - mozversion application_remotingname: firefox-dev 13:09:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:09:01 INFO - mozversion application_vendor: Mozilla 13:09:01 INFO - mozversion application_version: 52.0a2 13:09:01 INFO - mozversion platform_buildid: 20161222112653 13:09:01 INFO - mozversion platform_changeset: 3f796290f90ecb3a66af13f2ea0435859a38b57a 13:09:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:09:01 INFO - mozversion platform_version: 52.0a2 13:09:01 INFO - using testdate: 1482440941 13:09:01 INFO - actual date: 1482440941 13:09:01 INFO - starting webserver on 'localhost:34854' 13:09:01 INFO - SUITE-START | Running 2 tests 13:09:01 INFO - TEST-START | dromaeo_css 13:09:01 INFO - operating with platform_type : linux_ 13:09:01 INFO - Initialising browser for dromaeo_css test... 13:09:01 INFO - TEST-INFO | started process 10497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkN4iGa/profile http://localhost:34854/getInfo.html) 13:09:05 INFO - PROCESS | 10497 | __metrics Screen width/height:1600/1200 13:09:05 INFO - PROCESS | 10497 | colorDepth:24 13:09:05 INFO - PROCESS | 10497 | Browser inner width/height: 1024/697 13:09:05 INFO - PROCESS | 10497 | __metrics 13:09:06 INFO - PROCESS | 10497 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:09:06 INFO - PROCESS | 10497 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:09:07 INFO - PROCESS | 10497 | console.error: PushService: 13:09:07 INFO - PROCESS | 10497 | stateChangeProcessEnqueue: Error transitioning state 13:09:07 INFO - PROCESS | 10497 | UnknownError 13:09:07 INFO - TEST-INFO | 10497: exit 0 13:09:07 INFO - Browser initialized. 13:09:07 INFO - Running cycle 1/1 for dromaeo_css test... 13:09:07 INFO - TEST-INFO | started process 10593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkN4iGa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:09:19 INFO - PROCESS | 10593 | RSS: Main: 144101376 13:09:19 INFO - PROCESS | 10593 | 13:10:10 INFO - PROCESS | 10593 | 1482441010817 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] 13:12:21 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34854/tests/dromaeo/cssquery-ext.html) 13:12:22 INFO - PROCESS | 10593 | RSS: Main: 243621888 13:12:22 INFO - PROCESS | 10593 | 13:15:25 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-ext.html (next: http://localhost:34854/tests/dromaeo/cssquery-jquery.html) 13:15:25 INFO - PROCESS | 10593 | RSS: Main: 226381824 13:15:25 INFO - PROCESS | 10593 | 13:18:27 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34854/tests/dromaeo/cssquery-mootools.html) 13:18:27 INFO - PROCESS | 10593 | RSS: Main: 175591424 13:18:27 INFO - PROCESS | 10593 | 13:21:29 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34854/tests/dromaeo/cssquery-prototype.html) 13:21:30 INFO - PROCESS | 10593 | RSS: Main: 231550976 13:21:30 INFO - PROCESS | 10593 | 13:24:33 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34854/tests/dromaeo/cssquery-yui.html) 13:24:33 INFO - PROCESS | 10593 | RSS: Main: 173752320 13:24:33 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | Cycle 1(1): loaded http://localhost:34854/tests/dromaeo/cssquery-yui.html (next: http://localhost:34854/tests/dromaeo/cssquery-dojo.html) 13:27:36 INFO - PROCESS | 10593 | RSS: Main: 270614528 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | __start_tp_report 13:27:36 INFO - PROCESS | 10593 | _x_x_mozilla_page_load 13:27:36 INFO - PROCESS | 10593 | _x_x_mozilla_page_load_details 13:27:36 INFO - PROCESS | 10593 | |i|pagename|runs| 13:27:36 INFO - PROCESS | 10593 | |0;dojo.html;3229.1442767666567;3259.9185020374503;3266.4447044002522;3286.5070239464094;3291.0784980205535;5522.0888553388695;5603.327600687913;5622.859428514289;5638.295213098363;5645.661260324383;5588.86027849304;5629.380768115504;5636.915446268299;5638.351589567191;5657.603967722261;5064.924026139611;5100.821471248507;5131.435542090367;5153.742312884341;5155.71643559604;5030.748462576875;5044.646874718771;5069.771860266297;5157.097507936115;5184.1186998210205;5100.744962751866;5145.511176438233;5149.510796474329;5149.6910185389;5157.045946499891;5151.072806894757;5151.356080489939;5158.200478925792;5161.612879034087;5189.922151167698;4913.533214344631;4944.87637809054;5072.644914855961;5079.593632509391;5138.820141295037;5495.587830912697;5507.173923911405;5512.421195774426;5554.694491802949;5567.276254086943;5884.705764711747;5918.171455996164;6000.639961602318;6044.909326360108;6050.394960503959;5739.139129130622;5770.971145144247;6086.300075491331;6086.421789929949;6107.4197951194565;5645.463680950304;5661.2923384576925;5680.4319568042865;5703.0589952657765;5713.8285851424525;6196.597221180609;6200.844978875564;6200.937990620036;6208.068789681584;6209.875802483925;5780.624259423124;5800.53595712342;5946.375630558816;5952.464278214981;5959.433853783884;5903.940960590339;5925.525957923356;5925.762969481259;6008.579399441997;6053.606515576474;5947.31605865331;5976.970115149396;5980.910286345708;5986.2217911671205;6001.939980600138;5784.88430231393;5996.130561068708;6003.549733769984;6007.669578173242;6038.849028774228;4548.545145485425;4592.6555508337005;4599.310103484438;4604.539546045436;4604.677672562955;4108.281050816155;4128.2156390285745;4130.793460326971;4162.5629308922735;4168.374743788456;5695.45893140151;5696.1455781633085;5696.401877802854;5700.030994730906;5714.171445140431;5814.592978491465;5829.970850145722;5950.285965684146;5987.341392446828;6043.7280322385595;5729.799457018984;5735.827925162252;5742.167385729046;5751.741171647286;5768.798092066758;5196.038732834438;5206.5314121729225;5208.010478009166;5208.583313335;5234.188700751313;6093.817185484354;6130.969345153246;6134.631922084511;6221.626702397871;6271.811845644638;5954.612950158225;6080.817575472743;6089.847753806013;6106.816795496142;6108.847278818065;6281.371862813682;6283.465905398092;6293.433590976834;6293.992961126198;6298.559100863079;5727.255456790591;5748.913766293425;5982.641041537521;5989.131575921554;5989.760409583742;5958.404159584007;5993.520518358608;6014.338422773404;6101.145839582373;6112.602680825732;5894.086416605433;5930.555208359304;5938.6436813791315;5940.46535811779;5941.049432090845;5878.2064421302575;5935.881282374415;5937.524998000236;5941.346451890202;5943.762249509971;5613.270274864241;5645.4072322405555;5711.942880571307;5721.5136713379825;5738.971305143447;5892.35184129754;5895.9115613266695;5901.262342207224;5912.379200184091;5913.319968203712;5610.9158362623775;5622.8313150605545;5629.4652008059165;5761.078227483583;5783.681897495678 13:27:36 INFO - PROCESS | 10593 | |1;ext.html;550.8808897246068;576.9884602307953;599.113312297799;605.7122866638348;610.3042531514072;34134.317313653715;34738;45421.31868021978;45724.542754572445;45744.542554574444;43009;47167.292490612585;47202.76398618011;47206.0558788824;47382.0523589528;8472.66109355628;8813.38306318558;8956.238719708832;8964.013958464564;8969.372143949926;8459.11179326171;10735.624253151142;10984.395858227794;10984.890151098507;11242;11021.779564408707;11096.223264371498;11096.278741881752;11097.11223102154;11105.444727763619;10858.891411085906;10914;10916.617918372898;10917.781644367147;10922.672319830417;10778.461076946121;10813.945930270298;10829.133669306437;10840.403777792219;10853.945730271376;44271.77864110691;44339;44433.555664443586;44510.33234501485;44536.10927781426;3700.2414505026404;3738.906527336811;3755.6244375562496;3818.732688711791;3877.806109694532;32300.515492267634;32746;33052;33108.66891331104;33450.83274583636;4417.51407345195;4489.169503641837;4638.9536104638855;4643.466001409847;4748.311494833264;354083;355310;359353;361331;362359.1882040599;61608;61832;61864.69067654633;61922.69038654778;61982;42159.578404215565;42719;42771;43092;43119.353209701876;18261.63476730458;18499.260029598667;18512.444626660952;18514.814851851577;18523.259069637064;12192.451339689735;12388.752224955631;13902.16587004783;13945.16329020262;14144.929275353557;18344;18387.26450941974;18434.539136521693;18466.907665461586;18548.350807721665;7305.305995930378;7388.778336649909;7440.3675687567165;7460.328570428579;7462.813429664302;975.2977855943709;1046.210111365914;1054.1145437832104;1071.3036526257995;1170.087331881134;33596.160095997795;34126;34369;34552.782899543;35059.474107887894;1088.8911108889047;1130.5929865248504;1213.2538488829307;1214.4474264209764;1225.2587184753097;15584.766228506582;17009.149542522824;17572.0127578312;17977;18046.097695115455;505940;510499;510715;510854;512233;60942.390576094556;61307.708460407346;61524.38475615186;61667.38332616706;61765.691171543855;1318.5451019398292;1342.6710455938162;1381.647679841634;1410.5204230561658;1441.0921119694735;32770.34459310848;34907.47638785471;35096.29807403889;37650.246995060494;37835.62164378431;57169.714151428976;57757.711211443675;57781.13328300163;57795.42204577901;57863.710681446326;443888;447244.58266252064;448167;449025;449460;26763.86618066897;28831.5675264867;30614.387712246076;30622.387552249274;31517.52723709192;49055.50944490652;49088.5091149084;49252.2612160825;49679.75160124176;49904.25143622776;41778.79110604549;41811.37282940819;42664.81609993011;42830.35754463623;43353.56646433495;40610.1877962445;41050.38424423696;41742;41750.37374439325;43080.35379469248;42053.78973105115;42745;43092;43685.344719828594;43814;34999.65000349964;37748.81125594355;37884.242315152995;37984.430233545965;38592.80703596464;28504;28521.572176416954;28708.282292942844;28749;28828 13:27:36 INFO - PROCESS | 10593 | |2;jquery.html;422.5647582989522;432.17263170386775;435.1145419072189;435.30786050180217;444.24700133274115;19044.61910761784;19533.41399758008;20284.391468255977;20324.491887702796;20408.897955510238;18873.62252754944;18965;19209.231630734754;19400.708989365172;19567;5738.913916291259;5891.263592050994;5905.852353691149;5917.497012753921;5927.555433342495;5602.467765562265;5781.971090144543;5819.883602327951;5907.172995780573;5909.704514774266;5830.5044071254;5830.708464576775;5832.650040997532;5834.941650583482;5835;5624.915626265589;5801.88396232073;5828.591998560102;5831.6209446386065;5838.095095260242;5242.9213561796605;5265;5272.314599102092;5276.577873770089;5277.683338999673;23574.7642523576;23722.169724059575;23879.641805372932;23899.52200955971;24136.2759117225;2469.962950555743;2496.488219914931;2550.757678020585;2784.693683694792;3108.3938631966776;14851.480198193012;15040.87193460495;15101.697966040618;15174.165420901845;15339.386424543005;1944.8638595298335;1949.964487401724;1974.9828838148364;2051.0872661665567;2051.4358551398336;75111;75573.62213188954;76528;87591.12408875958;90276;11318.717032074099;11631.83681631847;11770.234934729215;11836.940815295868;11909.940450297692;17080.48758537246;17090.401835935932;17109.14454277281;17118.315267389164;17158;8272.33821294295;8288.58557072144;8474.618642161118;8638.784030399165;8896.377253592316;7969.163237859942;8077.232662897015;8077.232662897015;8277.503349798912;8330;4982.302477653059;5118.411382690963;5133.897322053538;5140.897182056338;5281.815136470205;2116.629375099867;2122.904469298885;2124.214040804912;2152.652625167879;2153.2033147735438;769.734441617641;900.594732370436;957.8840650642063;1013.3362647465922;1024.2369434771142;19314.517137071685;20438.284660037123;20500.17999280012;20510.589788204154;20631.896840516;1014.1329163565193;1017.7404761785846;1020.4846552490944;1041.8124737547162;1046.2989796836139;10638.83586603529;11461.255018423775;11477.139214558942;11507;11512;328081;328408;330659;434212;446454;95305.52347238219;95374;99750.5012474933;100271;100792.49603751935;1031.9277650564538;1033.2921948465325;1058.317385286486;1076.1498416251231;1080.4921686807188;17751.822481775016;17912.193951271962;18203.726944096114;18281.17734701915;18287.359942401952;39227.41158882676;39310.80344598259;39412.40881386839;39766.20467590574;40261.59738402579;55713.7214313942;55751.16373254323;56697.14954275772;56727;57559.42440575708;9006.009338972839;9049.864252036094;9057.909420905706;9139.817203656023;9194.26445884341;7390.5196162249285;11774.293542387484;12210.26738395699;12655.620331390073;13561.660958476117;5705.714714264187;11532.769344612892;11868.821967670665;11947.402629868646;12031.578894738643;11253.66239012831;11419.37193454368;11430.142739294752;11652.184347095623;11849.703757405789;10723.142148627934;11446.771064578828;12039;12039.157258991787;12158.878411216128;8990.415622984747;9015.729528114167;9344.439333640003;9400.482973436254;9434.716958491255;10249.692509224735;10265.2301077418;10390.220733445172;11437.256578322715;11559 13:27:36 INFO - PROCESS | 10593 | |3;mootools.html;1490.746573082576;1528.7095451864147;1685.6628674265141;1819.654265689518;1840.9171587278572;7949.205079492048;8446.28206602438;8453.323734101272;8455.746327610173;8457.492550446977;7394.149672787631;7599.392048636109;7973.960130199355;8119.147489513604;8334.541600211985;2410.7589241075884;2436.805055595557;2439.9024039038504;2440.1947357372114;2441.2310122311414;2403.675503806981;2430.1980346485707;2431.6109422492405;2437.2079074300837;2445.4497738008986;2136.476563242008;2203.294945617403;2206.646936490162;2223.132978138527;2309.180241014441;2402.3633737059695;2430.2344761400277;2436.110819550869;2441.8901149448316;2447.143499775082;2455.5683828229076;2479.776820086201;2496.4383013821925;2496.6379874918216;2500.1374525788574;8284.130166332508;8431.74704758852;8437.409381343308;8441.198086181803;8449.535275559841;5246.685198888079;5369.167778994262;5372.7313634318125;5378.757955891994;5388.78444862205;3228.9677103229137;3355.6644335566248;3372.477266023746;3405.1487128217946;3412;1070.2829104500004;1111.1222134513725;1117.9602969238606;1128.1933417606451;1145.301366166646;11154.498047587878;11168.553257869675;11180.944095279552;11235.382053987027;11282.153838462065;4743.739094349775;4807.375041244686;4852.223644216979;4896.36347274852;4962.950370496321;9076.727698169065;9142;9142.3600347975;9144.497052662035;9150.130737579919;5374.5700343972385;5378.058839703036;5378.354597448331;5383.7308134593895;5386.434424385383;4804.351412559329;4896;4969.130402179604;4971.577415919615;5066.873328166826;3714.2200137971327;3772.962270377316;3803.0682482791894;3850.7111966602615;3876.767393956315;1171.1918776044502;1183.4378670131618;1196.6888608961558;1218.9512419503299;1221.2367270455966;772.1776308231715;806.9757907262791;886.2068448738343;956.5121787888227;983.1299300119446;5291.365036195682;5331.360236771612;5417.079096553595;5462.672239665553;5640.069388550925;905.9728208153766;949.1505102932837;963.5182408795603;968.1915600473683;985.8176237396104;3815.980920095382;3859.1702783901596;3929.4891664083484;4006.8597599084474;4024.3762216856435;10212.897871021194;10284.588616455258;10427.426491542887;10428.791424171626;10437.165026797838;10022;10085;10268.58925642966;10278.17774578032;10338.53476593555;7557.4331925105835;7712.190220026929;7901.170377110436;7953.840923181504;7993.560354180576;5426.375966763872;5588.469095435927;5738.454846789548;5754.625949313281;5763.711814409179;9538;9539.379940304136;9569.665061722806;9625.903740962502;9717.17404020666;9084.182423581646;9434.716958491255;9466.668666596635;9658.034196580285;9677;7279.381252593377;7337.523061001018;7340.632968351668;7348.669309881175;7395.445341599294;7865.60671966388;7892.289693927574;7898.407619428681;7938.3563340847;8033.758987230392;7287.963560182166;7354.8896766549615;7370.815729606588;7376.151742549461;7487.850242995;7194.316539928698;7237.131544214517;7270.163931147986;7310.707571697072;7503.66233519482;6496.675166241764;6508.869822603616;6541.771038013837;6565.376289252514;6605.273419923708;4856.927146092741;4889.9022019560125;4976.05361592893;4989.775460104232;5057.291979122852;4783.976080119716;4890.462049174517;4916.975415122902;4929.950700493093;4969.577585905238 13:27:36 INFO - PROCESS | 10593 | |4;prototype.html;332.60420100080887;348.38162261984974;363.7217528590628;363.9472276519903;365.9231561372112;5079.517445842648;5235.9266350398175;5325.62720609557;5349.866253343668;5366.543843773275;5182.611304152185;5214.06146893559;5230.816921407742;5291.126964050936;5297.841064768054;4186.790660466964;4198.013466835291;4201.1807697499;4205.243056249874;4231.815091774292;4017.337139372015;4108.77401742904;4125.154343359604;4135.31767258402;4190.497140343163;4073.287174744423;4140.267423500491;4145.5647157048525;4157.937630935538;4173.373993900909;4137.834486620532;4153.563875793058;4162.458880345566;4163.770992595406;4184.958150418487;3694.2796154749835;3753.6621704046493;3778.263238668461;3784.2053168834577;3791.2939177370295;5084.694918304876;5098.490150984871;5106.391486681683;5113.923291150636;5120.385553733576;4796.400449943757;4810.230363141915;4817.927731084036;4824.300476430898;4824.662273640846;5231.424543300272;5431.674099553999;5534.723263836792;5545.528630066449;5560.913692900439;4031.455753473302;4041.5756345583586;4042.797860106983;4042.797860106983;4058.5738497457637;5642.984262832689;5689.6586204827845;5694.629849059839;5709.942900570983;5741.25363702716;4069.2471892699355;4133.152703695735;4153.273177193979;4157.8960525987095;4184.163167366539;4186.183694179666;4197.496300443966;4202.936955945664;4223.092035212383;4232.936505952413;4508.887277818081;4566.337881007302;4576;4689.671722979427;4716.316134160527;5485.31219702351;5497.8075767347955;5501.477359650827;5522.91715624266;5528.336599608073;1388.6944872128115;1409.9647508812157;1425.7647488164337;1425.8003879456885;1428.2287564715145;945.2674177512346;956.3831328793028;958.9664361747444;966.8114717629994;976.7216343342113;5134.409542902539;5140.948590514122;5170.482951704799;5174.689518628894;5178.792848286102;5425.782968681208;5432.538234250054;5463.754131064112;5525.585581081435;5543.916841247385;5148.2277658350795;5197.58419326453;5424.294841670558;5426.945730542723;5438.401775804658;2888.9277768055967;2891.6385451818524;2897.6812550619416;2898.7246211609863;2912.432075745209;5615.719214039364;5675.829725108253;5686.829395118153;5696.51579615729;5697.886042279131;5794.449527294901;5808.970955145197;5823.5341172706085;5829.659178388994;5846.1230815377185;5886.205362276038;5886.646801191942;5905.025670764448;5930.82700755094;5942.257217847769;5509.713468910518;5665.546756259571;5673.461021202979;5701.258836351248;5724.599278050497;5599.244102046172;5611.270534830446;5611.382747897646;5613.298337707786;5628.465295796893;5645.633033852787;5889.204957330706;5890.970545147246;5906.725910524393;5912.822615321547;4119;4152.584741525823;4167.604077612622;4172.415861779414;4178.770167640809;5443.428440013741;5536.52939500147;5567.972160139173;5693.345265294379;5738.741756620879;5494.516480550309;5575.9163612545035;5594.636348637326;5596.097326908871;5605;5528.115501519737;5536.252605898152;5558.221369161991;5594.188842617717;5600.607957443103;5278;5483.533899618577;5532.75102620375;5546.528545073714;5550.777968881361;5509.972450137724;5594.272744543184;5601.60788744784;5606.411326810626;5611.3266408031295;5251.816186433456;5449.7275136243825;5464.28964234647;5475.4250803665045;5492.231087647652 13:27:36 INFO - PROCESS | 10593 | |5;yui.html;775.151209425679;802.48239885274;839.7480755773269;840.6595328891793;895.6014573514784;14450.205238711867;14554.63613409664;14611.634709132277;14658.999999999987;14677.045992010511;13992.580222593338;14707.11757294563;15151.62120946977;15235.162066086361;15815.130167840764;721.2426951700719;738.2211766586249;843.1989609870632;844.3203221406765;867.4578388507183;831.71721614651;859.6948083430386;860.0152825015354;860.3461369359269;860.9483430994129;904.4030939579878;906.3247880329164;907.7458311672742;909.3861643390718;909.6952520905504;743.9888401673979;766.3026645752338;898.7393655839832;899.5637115998735;899.9055099214554;568.2215364950004;644.3266786208424;658.5554750543364;659.9835004124935;660.3792435111028;13743.450261989608;13845.861541384558;13902;13906.721865562633;13917.164970101827;13239.205647661074;13351.198928064347;13351.666208344868;13429;13489.527866524624;11873.16887817853;12080.758384832254;12117.394130293538;12267.57063502773;12270.938645306805;4467.128909862578;4468.620167285784;4472;4511.503734589192;4639.350490931272;62661.686691566705;63471;63706.362936370504;63949.360506394805;65098.674506627634;11136.610218642309;11215.327080375204;11413.771724565462;11490.310581364978;11522.193446458667;20553.89723051375;20562.177512899616;20563;20656.17375305001;20772.169113235603;8462.746117616482;8482.10937851529;8554.743357699279;8784.692535761218;8819.735407937773;4754.548317909793;4788.138135135709;4816.181249187646;4840.15297322967;4867.318575399447;3537.699295559906;3651.6348365163803;3665.120371110914;3667.6149004354693;3667.8166091695307;637.6843462486006;645.0614356111846;654.254150268694;664.0935123556311;667.0461240426237;603.6709993053709;623.3735096228352;704.8590281943632;740.7703611880227;775.2054144501818;9533.380330278509;9550.331476796557;9729.659461918798;9884;10069.345492542961;642.4731719989657;643.6009674002148;753.9773806785805;767.5548182054395;789.3724489031234;4585.403897493305;4611.9077618447445;4782.569568738831;4786.521347865186;4843.878903027453;51078.48921510737;69290;70453.94319085218;90246.54876725575;94804.15587532385;78492.60753696195;79460.60269698614;80287.59856200681;83262.58368708118;83994;71169.6441517789;72117.63941180366;73881;74636.25363746293;76980.61509692416;9270.243351320785;9553.761155970878;9666.854997175189;9678.612855485984;9742.707718768448;47681;47820.760896195294;48110.27834582554;48936.75531622319;49421.50578494169;58774.7061264708;63436.36563634305;66214;66748;67899;11384.772304553697;11446.255993360404;11480.827787583026;11537.134714896583;11593.478293476983;12230.75538489243;12260.693482663004;12557;12758.48966041348;13117.344132793512;11970.880291197325;12553.560625378068;12557;12940.223586584834;13145.34273286351;11654.76690466169;11744.354060526754;11748.58879939198;12036.157468977437;12335.444904979118;11960.820587691365;12020.098492612915;12215.877841221474;12337.814932775836;12697.55558555446;10133.189344852246;10244.334118282288;10282.588696452358;10548.314359566604;10606.416647084176;10415.270931034755;10790.858008209449;11040.723981900517;11133.944330278297;11184 13:27:36 INFO - PROCESS | 10593 | __end_tp_report 13:27:36 INFO - PROCESS | 10593 | __start_cc_report 13:27:36 INFO - PROCESS | 10593 | _x_x_mozilla_cycle_collect,1006 13:27:36 INFO - PROCESS | 10593 | __end_cc_report 13:27:36 INFO - PROCESS | 10593 | __startTimestamp1482442056586__endTimestamp 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | ------- Summary: start ------- 13:27:36 INFO - PROCESS | 10593 | Number of tests: 6 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#0] dojo.html Cycles:165 Average:5578.53 Median:5742.17 stddev:628.34 (10.9%) stddev-sans-first:602.63 13:27:36 INFO - PROCESS | 10593 | Values: 3229.1 3259.9 3266.4 3286.5 3291.1 5522.1 5603.3 5622.9 5638.3 5645.7 5588.9 5629.4 5636.9 5638.4 5657.6 5064.9 5100.8 5131.4 5153.7 5155.7 5030.7 5044.6 5069.8 5157.1 5184.1 5100.7 5145.5 5149.5 5149.7 5157.0 5151.1 5151.4 5158.2 5161.6 5189.9 4913.5 4944.9 5072.6 5079.6 5138.8 5495.6 5507.2 5512.4 5554.7 5567.3 5884.7 5918.2 6000.6 6044.9 6050.4 5739.1 5771.0 6086.3 6086.4 6107.4 5645.5 5661.3 5680.4 5703.1 5713.8 6196.6 6200.8 6200.9 6208.1 6209.9 5780.6 5800.5 5946.4 5952.5 5959.4 5903.9 5925.5 5925.8 6008.6 6053.6 5947.3 5977.0 5980.9 5986.2 6001.9 5784.9 5996.1 6003.5 6007.7 6038.8 4548.5 4592.7 4599.3 4604.5 4604.7 4108.3 4128.2 4130.8 4162.6 4168.4 5695.5 5696.1 5696.4 5700.0 5714.2 5814.6 5830.0 5950.3 5987.3 6043.7 5729.8 5735.8 5742.2 5751.7 5768.8 5196.0 5206.5 5208.0 5208.6 5234.2 6093.8 6131.0 6134.6 6221.6 6271.8 5954.6 6080.8 6089.8 6106.8 6108.8 6281.4 6283.5 6293.4 6294.0 6298.6 5727.3 5748.9 5982.6 5989.1 5989.8 5958.4 5993.5 6014.3 6101.1 6112.6 5894.1 5930.6 5938.6 5940.5 5941.0 5878.2 5935.9 5937.5 5941.3 5943.8 5613.3 5645.4 5711.9 5721.5 5739.0 5892.4 5895.9 5901.3 5912.4 5913.3 5610.9 5622.8 5629.5 5761.1 5783.7 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#1] ext.html Cycles:180 Average:60740.42 Median:37934.34 stddev:117118.72 (308.7%) stddev-sans-first:117360.08 13:27:36 INFO - PROCESS | 10593 | Values: 550.9 577.0 599.1 605.7 610.3 34134.3 34738.0 45421.3 45724.5 45744.5 43009.0 47167.3 47202.8 47206.1 47382.1 8472.7 8813.4 8956.2 8964.0 8969.4 8459.1 10735.6 10984.4 10984.9 11242.0 11021.8 11096.2 11096.3 11097.1 11105.4 10858.9 10914.0 10916.6 10917.8 10922.7 10778.5 10813.9 10829.1 10840.4 10853.9 44271.8 44339.0 44433.6 44510.3 44536.1 3700.2 3738.9 3755.6 3818.7 3877.8 32300.5 32746.0 33052.0 33108.7 33450.8 4417.5 4489.2 4639.0 4643.5 4748.3 354083.0 355310.0 359353.0 361331.0 362359.2 61608.0 61832.0 61864.7 61922.7 61982.0 42159.6 42719.0 42771.0 43092.0 43119.4 18261.6 18499.3 18512.4 18514.8 18523.3 12192.5 12388.8 13902.2 13945.2 14144.9 18344.0 18387.3 18434.5 18466.9 18548.4 7305.3 7388.8 7440.4 7460.3 7462.8 975.3 1046.2 1054.1 1071.3 1170.1 33596.2 34126.0 34369.0 34552.8 35059.5 1088.9 1130.6 1213.3 1214.4 1225.3 15584.8 17009.1 17572.0 17977.0 18046.1 505940.0 510499.0 510715.0 510854.0 512233.0 60942.4 61307.7 61524.4 61667.4 61765.7 1318.5 1342.7 1381.6 1410.5 1441.1 32770.3 34907.5 35096.3 37650.2 37835.6 57169.7 57757.7 57781.1 57795.4 57863.7 443888.0 447244.6 448167.0 449025.0 449460.0 26763.9 28831.6 30614.4 30622.4 31517.5 49055.5 49088.5 49252.3 49679.8 49904.3 41778.8 41811.4 42664.8 42830.4 43353.6 40610.2 41050.4 41742.0 41750.4 43080.4 42053.8 42745.0 43092.0 43685.3 43814.0 34999.7 37748.8 37884.2 37984.4 38592.8 28504.0 28521.6 28708.3 28749.0 28828.0 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#2] jquery.html Cycles:180 Average:26127.31 Median:24017.90 stddev:63204.35 (263.2%) stddev-sans-first:63352.19 13:27:36 INFO - PROCESS | 10593 | Values: 422.6 432.2 435.1 435.3 444.2 19044.6 19533.4 20284.4 20324.5 20408.9 18873.6 18965.0 19209.2 19400.7 19567.0 5738.9 5891.3 5905.9 5917.5 5927.6 5602.5 5782.0 5819.9 5907.2 5909.7 5830.5 5830.7 5832.7 5834.9 5835.0 5624.9 5801.9 5828.6 5831.6 5838.1 5242.9 5265.0 5272.3 5276.6 5277.7 23574.8 23722.2 23879.6 23899.5 24136.3 2470.0 2496.5 2550.8 2784.7 3108.4 14851.5 15040.9 15101.7 15174.2 15339.4 1944.9 1950.0 1975.0 2051.1 2051.4 75111.0 75573.6 76528.0 87591.1 90276.0 11318.7 11631.8 11770.2 11836.9 11909.9 17080.5 17090.4 17109.1 17118.3 17158.0 8272.3 8288.6 8474.6 8638.8 8896.4 7969.2 8077.2 8077.2 8277.5 8330.0 4982.3 5118.4 5133.9 5140.9 5281.8 2116.6 2122.9 2124.2 2152.7 2153.2 769.7 900.6 957.9 1013.3 1024.2 19314.5 20438.3 20500.2 20510.6 20631.9 1014.1 1017.7 1020.5 1041.8 1046.3 10638.8 11461.3 11477.1 11507.0 11512.0 328081.0 328408.0 330659.0 434212.0 446454.0 95305.5 95374.0 99750.5 100271.0 100792.5 1031.9 1033.3 1058.3 1076.1 1080.5 17751.8 17912.2 18203.7 18281.2 18287.4 39227.4 39310.8 39412.4 39766.2 40261.6 55713.7 55751.2 56697.1 56727.0 57559.4 9006.0 9049.9 9057.9 9139.8 9194.3 7390.5 11774.3 12210.3 12655.6 13561.7 5705.7 11532.8 11868.8 11947.4 12031.6 11253.7 11419.4 11430.1 11652.2 11849.7 10723.1 11446.8 12039.0 12039.2 12158.9 8990.4 9015.7 9344.4 9400.5 9434.7 10249.7 10265.2 10390.2 11437.3 11559.0 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#3] mootools.html Cycles:180 Average:5535.44 Median:5269.03 stddev:3003.59 (57.0%) stddev-sans-first:2996.63 13:27:36 INFO - PROCESS | 10593 | Values: 1490.7 1528.7 1685.7 1819.7 1840.9 7949.2 8446.3 8453.3 8455.7 8457.5 7394.1 7599.4 7974.0 8119.1 8334.5 2410.8 2436.8 2439.9 2440.2 2441.2 2403.7 2430.2 2431.6 2437.2 2445.4 2136.5 2203.3 2206.6 2223.1 2309.2 2402.4 2430.2 2436.1 2441.9 2447.1 2455.6 2479.8 2496.4 2496.6 2500.1 8284.1 8431.7 8437.4 8441.2 8449.5 5246.7 5369.2 5372.7 5378.8 5388.8 3229.0 3355.7 3372.5 3405.1 3412.0 1070.3 1111.1 1118.0 1128.2 1145.3 11154.5 11168.6 11180.9 11235.4 11282.2 4743.7 4807.4 4852.2 4896.4 4963.0 9076.7 9142.0 9142.4 9144.5 9150.1 5374.6 5378.1 5378.4 5383.7 5386.4 4804.4 4896.0 4969.1 4971.6 5066.9 3714.2 3773.0 3803.1 3850.7 3876.8 1171.2 1183.4 1196.7 1219.0 1221.2 772.2 807.0 886.2 956.5 983.1 5291.4 5331.4 5417.1 5462.7 5640.1 906.0 949.2 963.5 968.2 985.8 3816.0 3859.2 3929.5 4006.9 4024.4 10212.9 10284.6 10427.4 10428.8 10437.2 10022.0 10085.0 10268.6 10278.2 10338.5 7557.4 7712.2 7901.2 7953.8 7993.6 5426.4 5588.5 5738.5 5754.6 5763.7 9538.0 9539.4 9569.7 9625.9 9717.2 9084.2 9434.7 9466.7 9658.0 9677.0 7279.4 7337.5 7340.6 7348.7 7395.4 7865.6 7892.3 7898.4 7938.4 8033.8 7288.0 7354.9 7370.8 7376.2 7487.9 7194.3 7237.1 7270.2 7310.7 7503.7 6496.7 6508.9 6541.8 6565.4 6605.3 4856.9 4889.9 4976.1 4989.8 5057.3 4784.0 4890.5 4917.0 4930.0 4969.6 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#4] prototype.html Cycles:180 Average:4666.03 Median:5294.48 stddev:1352.93 (25.6%) stddev-sans-first:1317.05 13:27:36 INFO - PROCESS | 10593 | Values: 332.6 348.4 363.7 363.9 365.9 5079.5 5235.9 5325.6 5349.9 5366.5 5182.6 5214.1 5230.8 5291.1 5297.8 4186.8 4198.0 4201.2 4205.2 4231.8 4017.3 4108.8 4125.2 4135.3 4190.5 4073.3 4140.3 4145.6 4157.9 4173.4 4137.8 4153.6 4162.5 4163.8 4185.0 3694.3 3753.7 3778.3 3784.2 3791.3 5084.7 5098.5 5106.4 5113.9 5120.4 4796.4 4810.2 4817.9 4824.3 4824.7 5231.4 5431.7 5534.7 5545.5 5560.9 4031.5 4041.6 4042.8 4042.8 4058.6 5643.0 5689.7 5694.6 5709.9 5741.3 4069.2 4133.2 4153.3 4157.9 4184.2 4186.2 4197.5 4202.9 4223.1 4232.9 4508.9 4566.3 4576.0 4689.7 4716.3 5485.3 5497.8 5501.5 5522.9 5528.3 1388.7 1410.0 1425.8 1425.8 1428.2 945.3 956.4 959.0 966.8 976.7 5134.4 5140.9 5170.5 5174.7 5178.8 5425.8 5432.5 5463.8 5525.6 5543.9 5148.2 5197.6 5424.3 5426.9 5438.4 2888.9 2891.6 2897.7 2898.7 2912.4 5615.7 5675.8 5686.8 5696.5 5697.9 5794.4 5809.0 5823.5 5829.7 5846.1 5886.2 5886.6 5905.0 5930.8 5942.3 5509.7 5665.5 5673.5 5701.3 5724.6 5599.2 5611.3 5611.4 5613.3 5628.5 5645.6 5889.2 5891.0 5906.7 5912.8 4119.0 4152.6 4167.6 4172.4 4178.8 5443.4 5536.5 5568.0 5693.3 5738.7 5494.5 5575.9 5594.6 5596.1 5605.0 5528.1 5536.3 5558.2 5594.2 5600.6 5278.0 5483.5 5532.8 5546.5 5550.8 5510.0 5594.3 5601.6 5606.4 5611.3 5251.8 5449.7 5464.3 5475.4 5492.2 13:27:36 INFO - PROCESS | 10593 | 13:27:36 INFO - PROCESS | 10593 | [#5] yui.html Cycles:180 Average:17845.42 Median:4828.17 stddev:23566.98 (488.1%) stddev-sans-first:23598.23 13:27:36 INFO - PROCESS | 10593 | Values: 775.2 802.5 839.7 840.7 895.6 14450.2 14554.6 14611.6 14659.0 14677.0 13992.6 14707.1 15151.6 15235.2 15815.1 721.2 738.2 843.2 844.3 867.5 831.7 859.7 860.0 860.3 860.9 904.4 906.3 907.7 909.4 909.7 744.0 766.3 898.7 899.6 899.9 568.2 644.3 658.6 660.0 660.4 13743.5 13845.9 13902.0 13906.7 13917.2 13239.2 13351.2 13351.7 13429.0 13489.5 11873.2 12080.8 12117.4 12267.6 12270.9 4467.1 4468.6 4472.0 4511.5 4639.4 62661.7 63471.0 63706.4 63949.4 65098.7 11136.6 11215.3 11413.8 11490.3 11522.2 20553.9 20562.2 20563.0 20656.2 20772.2 8462.7 8482.1 8554.7 8784.7 8819.7 4754.5 4788.1 4816.2 4840.2 4867.3 3537.7 3651.6 3665.1 3667.6 3667.8 637.7 645.1 654.3 664.1 667.0 603.7 623.4 704.9 740.8 775.2 9533.4 9550.3 9729.7 9884.0 10069.3 642.5 643.6 754.0 767.6 789.4 4585.4 4611.9 4782.6 4786.5 4843.9 51078.5 69290.0 70453.9 90246.5 94804.2 78492.6 79460.6 80287.6 83262.6 83994.0 71169.6 72117.6 73881.0 74636.3 76980.6 9270.2 9553.8 9666.9 9678.6 9742.7 47681.0 47820.8 48110.3 48936.8 49421.5 58774.7 63436.4 66214.0 66748.0 67899.0 11384.8 11446.3 11480.8 11537.1 11593.5 12230.8 12260.7 12557.0 12758.5 13117.3 11970.9 12553.6 12557.0 12940.2 13145.3 11654.8 11744.4 11748.6 12036.2 12335.4 11960.8 12020.1 12215.9 12337.8 12697.6 10133.2 10244.3 10282.6 10548.3 10606.4 10415.3 10790.9 11040.7 11133.9 11184.0 13:27:36 INFO - PROCESS | 10593 | -------- Summary: end -------- 13:27:36 INFO - PROCESS | 10593 | 13:27:37 INFO - TEST-INFO | 10593: exit 0 13:27:37 INFO - TEST-OK | dromaeo_css | took 1115789ms 13:27:37 INFO - TEST-START | kraken 13:27:37 INFO - operating with platform_type : linux_ 13:27:37 INFO - Initialising browser for kraken test... 13:27:37 INFO - TEST-INFO | started process 10910 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadbhhY/profile http://localhost:34854/getInfo.html) 13:27:41 INFO - PROCESS | 10910 | __metrics Screen width/height:1600/1200 13:27:41 INFO - PROCESS | 10910 | colorDepth:24 13:27:41 INFO - PROCESS | 10910 | Browser inner width/height: 1024/697 13:27:41 INFO - PROCESS | 10910 | __metrics 13:27:42 INFO - PROCESS | 10910 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:27:42 INFO - PROCESS | 10910 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:27:42 INFO - PROCESS | 10910 | console.error: PushService: 13:27:42 INFO - PROCESS | 10910 | stateChangeProcessEnqueue: Error transitioning state 13:27:42 INFO - PROCESS | 10910 | UnknownError 13:27:43 INFO - TEST-INFO | 10910: exit 0 13:27:43 INFO - Browser initialized. 13:27:43 INFO - Running cycle 1/1 for kraken test... 13:27:43 INFO - TEST-INFO | started process 11000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpadbhhY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:55 INFO - PROCESS | 11000 | RSS: Main: 144490496 13:27:55 INFO - PROCESS | 11000 | 13:27:57 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34854/tests/kraken/driver.html?testName=audio-beat-detection) 13:27:58 INFO - PROCESS | 11000 | RSS: Main: 185823232 13:27:58 INFO - PROCESS | 11000 | 13:28:01 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34854/tests/kraken/driver.html?testName=audio-dft) 13:28:01 INFO - PROCESS | 11000 | RSS: Main: 175493120 13:28:01 INFO - PROCESS | 11000 | 13:28:04 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34854/tests/kraken/driver.html?testName=audio-fft) 13:28:05 INFO - PROCESS | 11000 | RSS: Main: 266842112 13:28:05 INFO - PROCESS | 11000 | 13:28:07 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34854/tests/kraken/driver.html?testName=audio-oscillator) 13:28:07 INFO - PROCESS | 11000 | RSS: Main: 173256704 13:28:07 INFO - PROCESS | 11000 | 13:28:09 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34854/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:28:10 INFO - PROCESS | 11000 | RSS: Main: 175665152 13:28:10 INFO - PROCESS | 11000 | 13:28:13 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34854/tests/kraken/driver.html?testName=imaging-darkroom) 13:28:13 INFO - PROCESS | 11000 | RSS: Main: 214417408 13:28:13 INFO - PROCESS | 11000 | 13:28:17 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34854/tests/kraken/driver.html?testName=imaging-desaturate) 13:28:17 INFO - PROCESS | 11000 | RSS: Main: 213131264 13:28:17 INFO - PROCESS | 11000 | 13:28:20 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34854/tests/kraken/driver.html?testName=json-parse-financial) 13:28:21 INFO - PROCESS | 11000 | RSS: Main: 212062208 13:28:21 INFO - PROCESS | 11000 | 13:28:22 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34854/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:28:23 INFO - PROCESS | 11000 | RSS: Main: 174014464 13:28:23 INFO - PROCESS | 11000 | 13:28:24 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:28:25 INFO - PROCESS | 11000 | RSS: Main: 180867072 13:28:25 INFO - PROCESS | 11000 | 13:28:27 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:28:28 INFO - PROCESS | 11000 | RSS: Main: 190124032 13:28:28 INFO - PROCESS | 11000 | 13:28:30 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:28:31 INFO - PROCESS | 11000 | RSS: Main: 198815744 13:28:31 INFO - PROCESS | 11000 | 13:28:33 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:28:34 INFO - PROCESS | 11000 | RSS: Main: 195493888 13:28:34 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | Cycle 1(1): loaded http://localhost:34854/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34854/tests/kraken/driver.html?testName=ai-astar) 13:28:36 INFO - PROCESS | 11000 | RSS: Main: 247021568 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | __start_tp_report 13:28:36 INFO - PROCESS | 11000 | _x_x_mozilla_page_load 13:28:36 INFO - PROCESS | 11000 | _x_x_mozilla_page_load_details 13:28:36 INFO - PROCESS | 11000 | |i|pagename|runs| 13:28:36 INFO - PROCESS | 11000 | |0;ai-astar;101;110;112;112;111;112;111;111;111;111 13:28:36 INFO - PROCESS | 11000 | |1;audio-beat-detection;149;122;116;152;120;121;116;117;143;117 13:28:36 INFO - PROCESS | 11000 | |2;audio-dft;161;160;161;160;160;160;159;159;161;160 13:28:36 INFO - PROCESS | 11000 | |3;audio-fft;75;75;74;111;77;76;75;76;107;75 13:28:36 INFO - PROCESS | 11000 | |4;audio-oscillator;81;81;118;82;82;83;108;81;81;115 13:28:36 INFO - PROCESS | 11000 | |5;imaging-gaussian-blur;117;116;117;117;117;116;116;117;117;116 13:28:36 INFO - PROCESS | 11000 | |6;imaging-darkroom;146;146;147;147;148;146;146;146;146;146 13:28:36 INFO - PROCESS | 11000 | |7;imaging-desaturate;84;84;84;85;84;84;84;84;85;85 13:28:36 INFO - PROCESS | 11000 | |8;json-parse-financial;51;53;53;50;51;52;52;51;51;51 13:28:36 INFO - PROCESS | 11000 | |9;json-stringify-tinderbox;58;60;59;58;59;62;60;59;59;60 13:28:36 INFO - PROCESS | 11000 | |10;stanford-crypto-aes;74;83;75;75;75;81;75;75;74;75 13:28:36 INFO - PROCESS | 11000 | |11;stanford-crypto-ccm;124;130;122;130;122;121;128;123;170;123 13:28:36 INFO - PROCESS | 11000 | |12;stanford-crypto-pbkdf2;154;156;155;156;156;156;156;156;155;152 13:28:36 INFO - PROCESS | 11000 | |13;stanford-crypto-sha256-iterative;65;63;63;63;62;64;65;62;61;63 13:28:36 INFO - PROCESS | 11000 | __end_tp_report 13:28:36 INFO - PROCESS | 11000 | __start_cc_report 13:28:36 INFO - PROCESS | 11000 | _x_x_mozilla_cycle_collect,1608 13:28:36 INFO - PROCESS | 11000 | __end_cc_report 13:28:36 INFO - PROCESS | 11000 | __startTimestamp1482442116449__endTimestamp 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | ------- Summary: start ------- 13:28:36 INFO - PROCESS | 11000 | Number of tests: 14 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:3.29 (3.0%) stddev-sans-first:0.67 13:28:36 INFO - PROCESS | 11000 | Values: 101.0 110.0 112.0 112.0 111.0 112.0 111.0 111.0 111.0 111.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:121.50 stddev:14.59 (12.0%) stddev-sans-first:13.20 13:28:36 INFO - PROCESS | 11000 | Values: 149.0 122.0 116.0 152.0 120.0 121.0 116.0 117.0 143.0 117.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 13:28:36 INFO - PROCESS | 11000 | Values: 161.0 160.0 161.0 160.0 160.0 160.0 159.0 159.0 161.0 160.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.00 stddev:14.23 (19.0%) stddev-sans-first:14.86 13:28:36 INFO - PROCESS | 11000 | Values: 75.0 75.0 74.0 111.0 77.0 76.0 75.0 76.0 107.0 75.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:81.00 stddev:15.70 (19.4%) stddev-sans-first:16.22 13:28:36 INFO - PROCESS | 11000 | Values: 81.0 81.0 118.0 82.0 82.0 83.0 108.0 81.0 81.0 115.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 13:28:36 INFO - PROCESS | 11000 | Values: 117.0 116.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 13:28:36 INFO - PROCESS | 11000 | Values: 146.0 146.0 147.0 147.0 148.0 146.0 146.0 146.0 146.0 146.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 13:28:36 INFO - PROCESS | 11000 | Values: 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 85.0 85.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:51.50 stddev:0.97 (1.9%) stddev-sans-first:1.01 13:28:36 INFO - PROCESS | 11000 | Values: 51.0 53.0 53.0 50.0 51.0 52.0 52.0 51.0 51.0 51.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:1.17 (2.0%) stddev-sans-first:1.13 13:28:36 INFO - PROCESS | 11000 | Values: 58.0 60.0 59.0 58.0 59.0 62.0 60.0 59.0 59.0 60.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:75.00 stddev:3.12 (4.2%) stddev-sans-first:3.21 13:28:36 INFO - PROCESS | 11000 | Values: 74.0 83.0 75.0 75.0 75.0 81.0 75.0 75.0 74.0 75.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#11] stanford-crypto-ccm Cycles:10 Average:129.30 Median:126.00 stddev:14.69 (11.7%) stddev-sans-first:15.46 13:28:36 INFO - PROCESS | 11000 | Values: 124.0 130.0 122.0 130.0 122.0 121.0 128.0 123.0 170.0 123.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.20 Median:156.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 13:28:36 INFO - PROCESS | 11000 | Values: 154.0 156.0 155.0 156.0 156.0 156.0 156.0 156.0 155.0 152.0 13:28:36 INFO - PROCESS | 11000 | 13:28:36 INFO - PROCESS | 11000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.17 13:28:36 INFO - PROCESS | 11000 | Values: 65.0 63.0 63.0 63.0 62.0 64.0 65.0 62.0 61.0 63.0 13:28:36 INFO - PROCESS | 11000 | -------- Summary: end -------- 13:28:36 INFO - PROCESS | 11000 | 13:28:37 INFO - TEST-INFO | 11000: exit 0 13:28:37 INFO - TEST-OK | kraken | took 60129ms 13:28:37 INFO - SUITE-END | took 1175s 13:28:37 INFO - Completed test suite (00:19:36) 13:28:37 INFO - javascript benchmark 13:28:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.1442767666567, 3259.9185020374503, 3266.4447044002522, 3286.5070239464094, 3291.0784980205535, 5522.0888553388695, 5603.327600687913, 5622.859428514289, 5638.295213098363, 5645.661260324383, 5588.86027849304, 5629.380768115504, 5636.915446268299, 5638.351589567191, 5657.603967722261, 5064.924026139611, 5100.821471248507, 5131.435542090367, 5153.742312884341, 5155.71643559604, 5030.748462576875, 5044.646874718771, 5069.771860266297, 5157.097507936115, 5184.1186998210205, 5100.744962751866, 5145.511176438233, 5149.510796474329, 5149.6910185389, 5157.045946499891, 5151.072806894757, 5151.356080489939, 5158.200478925792, 5161.612879034087, 5189.922151167698, 4913.533214344631, 4944.87637809054, 5072.644914855961, 5079.593632509391, 5138.820141295037, 5495.587830912697, 5507.173923911405, 5512.421195774426, 5554.694491802949, 5567.276254086943, 5884.705764711747, 5918.171455996164, 6000.639961602318, 6044.909326360108, 6050.394960503959, 5739.139129130622, 5770.971145144247, 6086.300075491331, 6086.421789929949, 6107.4197951194565, 5645.463680950304, 5661.2923384576925, 5680.4319568042865, 5703.0589952657765, 5713.8285851424525, 6196.597221180609, 6200.844978875564, 6200.937990620036, 6208.068789681584, 6209.875802483925, 5780.624259423124, 5800.53595712342, 5946.375630558816, 5952.464278214981, 5959.433853783884, 5903.940960590339, 5925.525957923356, 5925.762969481259, 6008.579399441997, 6053.606515576474, 5947.31605865331, 5976.970115149396, 5980.910286345708, 5986.2217911671205, 6001.939980600138, 5784.88430231393, 5996.130561068708, 6003.549733769984, 6007.669578173242, 6038.849028774228, 4548.545145485425, 4592.6555508337005, 4599.310103484438, 4604.539546045436, 4604.677672562955, 4108.281050816155, 4128.2156390285745, 4130.793460326971, 4162.5629308922735, 4168.374743788456, 5695.45893140151, 5696.1455781633085, 5696.401877802854, 5700.030994730906, 5714.171445140431, 5814.592978491465, 5829.970850145722, 5950.285965684146, 5987.341392446828, 6043.7280322385595, 5729.799457018984, 5735.827925162252, 5742.167385729046, 5751.741171647286, 5768.798092066758, 5196.038732834438, 5206.5314121729225, 5208.010478009166, 5208.583313335, 5234.188700751313, 6093.817185484354, 6130.969345153246, 6134.631922084511, 6221.626702397871, 6271.811845644638, 5954.612950158225, 6080.817575472743, 6089.847753806013, 6106.816795496142, 6108.847278818065, 6281.371862813682, 6283.465905398092, 6293.433590976834, 6293.992961126198, 6298.559100863079, 5727.255456790591, 5748.913766293425, 5982.641041537521, 5989.131575921554, 5989.760409583742, 5958.404159584007, 5993.520518358608, 6014.338422773404, 6101.145839582373, 6112.602680825732, 5894.086416605433, 5930.555208359304, 5938.6436813791315, 5940.46535811779, 5941.049432090845, 5878.2064421302575, 5935.881282374415, 5937.524998000236, 5941.346451890202, 5943.762249509971, 5613.270274864241, 5645.4072322405555, 5711.942880571307, 5721.5136713379825, 5738.971305143447, 5892.35184129754, 5895.9115613266695, 5901.262342207224, 5912.379200184091, 5913.319968203712, 5610.9158362623775, 5622.8313150605545, 5629.4652008059165, 5761.078227483583, 5783.681897495678], "value": 5536.64273243156, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.8808897246068, 576.9884602307953, 599.113312297799, 605.7122866638348, 610.3042531514072, 34134.317313653715, 34738.0, 45421.31868021978, 45724.542754572445, 45744.542554574444, 43009.0, 47167.292490612585, 47202.76398618011, 47206.0558788824, 47382.0523589528, 8472.66109355628, 8813.38306318558, 8956.238719708832, 8964.013958464564, 8969.372143949926, 8459.11179326171, 10735.624253151142, 10984.395858227794, 10984.890151098507, 11242.0, 11021.779564408707, 11096.223264371498, 11096.278741881752, 11097.11223102154, 11105.444727763619, 10858.891411085906, 10914.0, 10916.617918372898, 10917.781644367147, 10922.672319830417, 10778.461076946121, 10813.945930270298, 10829.133669306437, 10840.403777792219, 10853.945730271376, 44271.77864110691, 44339.0, 44433.555664443586, 44510.33234501485, 44536.10927781426, 3700.2414505026404, 3738.906527336811, 3755.6244375562496, 3818.732688711791, 3877.806109694532, 32300.515492267634, 32746.0, 33052.0, 33108.66891331104, 33450.83274583636, 4417.51407345195, 4489.169503641837, 4638.9536104638855, 4643.466001409847, 4748.311494833264, 354083.0, 355310.0, 359353.0, 361331.0, 362359.1882040599, 61608.0, 61832.0, 61864.69067654633, 61922.69038654778, 61982.0, 42159.578404215565, 42719.0, 42771.0, 43092.0, 43119.353209701876, 18261.63476730458, 18499.260029598667, 18512.444626660952, 18514.814851851577, 18523.259069637064, 12192.451339689735, 12388.752224955631, 13902.16587004783, 13945.16329020262, 14144.929275353557, 18344.0, 18387.26450941974, 18434.539136521693, 18466.907665461586, 18548.350807721665, 7305.305995930378, 7388.778336649909, 7440.3675687567165, 7460.328570428579, 7462.813429664302, 975.2977855943709, 1046.210111365914, 1054.1145437832104, 1071.3036526257995, 1170.087331881134, 33596.160095997795, 34126.0, 34369.0, 34552.782899543, 35059.474107887894, 1088.8911108889047, 1130.5929865248504, 1213.2538488829307, 1214.4474264209764, 1225.2587184753097, 15584.766228506582, 17009.149542522824, 17572.0127578312, 17977.0, 18046.097695115455, 505940.0, 510499.0, 510715.0, 510854.0, 512233.0, 60942.390576094556, 61307.708460407346, 61524.38475615186, 61667.38332616706, 61765.691171543855, 1318.5451019398292, 1342.6710455938162, 1381.647679841634, 1410.5204230561658, 1441.0921119694735, 32770.34459310848, 34907.47638785471, 35096.29807403889, 37650.246995060494, 37835.62164378431, 57169.714151428976, 57757.711211443675, 57781.13328300163, 57795.42204577901, 57863.710681446326, 443888.0, 447244.58266252064, 448167.0, 449025.0, 449460.0, 26763.86618066897, 28831.5675264867, 30614.387712246076, 30622.387552249274, 31517.52723709192, 49055.50944490652, 49088.5091149084, 49252.2612160825, 49679.75160124176, 49904.25143622776, 41778.79110604549, 41811.37282940819, 42664.81609993011, 42830.35754463623, 43353.56646433495, 40610.1877962445, 41050.38424423696, 41742.0, 41750.37374439325, 43080.35379469248, 42053.78973105115, 42745.0, 43092.0, 43685.344719828594, 43814.0, 34999.65000349964, 37748.81125594355, 37884.242315152995, 37984.430233545965, 38592.80703596464, 28504.0, 28521.572176416954, 28708.282292942844, 28749.0, 28828.0], "value": 20986.877107630524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.5647582989522, 432.17263170386775, 435.1145419072189, 435.30786050180217, 444.24700133274115, 19044.61910761784, 19533.41399758008, 20284.391468255977, 20324.491887702796, 20408.897955510238, 18873.62252754944, 18965.0, 19209.231630734754, 19400.708989365172, 19567.0, 5738.913916291259, 5891.263592050994, 5905.852353691149, 5917.497012753921, 5927.555433342495, 5602.467765562265, 5781.971090144543, 5819.883602327951, 5907.172995780573, 5909.704514774266, 5830.5044071254, 5830.708464576775, 5832.650040997532, 5834.941650583482, 5835.0, 5624.915626265589, 5801.88396232073, 5828.591998560102, 5831.6209446386065, 5838.095095260242, 5242.9213561796605, 5265.0, 5272.314599102092, 5276.577873770089, 5277.683338999673, 23574.7642523576, 23722.169724059575, 23879.641805372932, 23899.52200955971, 24136.2759117225, 2469.962950555743, 2496.488219914931, 2550.757678020585, 2784.693683694792, 3108.3938631966776, 14851.480198193012, 15040.87193460495, 15101.697966040618, 15174.165420901845, 15339.386424543005, 1944.8638595298335, 1949.964487401724, 1974.9828838148364, 2051.0872661665567, 2051.4358551398336, 75111.0, 75573.62213188954, 76528.0, 87591.12408875958, 90276.0, 11318.717032074099, 11631.83681631847, 11770.234934729215, 11836.940815295868, 11909.940450297692, 17080.48758537246, 17090.401835935932, 17109.14454277281, 17118.315267389164, 17158.0, 8272.33821294295, 8288.58557072144, 8474.618642161118, 8638.784030399165, 8896.377253592316, 7969.163237859942, 8077.232662897015, 8077.232662897015, 8277.503349798912, 8330.0, 4982.302477653059, 5118.411382690963, 5133.897322053538, 5140.897182056338, 5281.815136470205, 2116.629375099867, 2122.904469298885, 2124.214040804912, 2152.652625167879, 2153.2033147735438, 769.734441617641, 900.594732370436, 957.8840650642063, 1013.3362647465922, 1024.2369434771142, 19314.517137071685, 20438.284660037123, 20500.17999280012, 20510.589788204154, 20631.896840516, 1014.1329163565193, 1017.7404761785846, 1020.4846552490944, 1041.8124737547162, 1046.2989796836139, 10638.83586603529, 11461.255018423775, 11477.139214558942, 11507.0, 11512.0, 328081.0, 328408.0, 330659.0, 434212.0, 446454.0, 95305.52347238219, 95374.0, 99750.5012474933, 100271.0, 100792.49603751935, 1031.9277650564538, 1033.2921948465325, 1058.317385286486, 1076.1498416251231, 1080.4921686807188, 17751.822481775016, 17912.193951271962, 18203.726944096114, 18281.17734701915, 18287.359942401952, 39227.41158882676, 39310.80344598259, 39412.40881386839, 39766.20467590574, 40261.59738402579, 55713.7214313942, 55751.16373254323, 56697.14954275772, 56727.0, 57559.42440575708, 9006.009338972839, 9049.864252036094, 9057.909420905706, 9139.817203656023, 9194.26445884341, 7390.5196162249285, 11774.293542387484, 12210.26738395699, 12655.620331390073, 13561.660958476117, 5705.714714264187, 11532.769344612892, 11868.821967670665, 11947.402629868646, 12031.578894738643, 11253.66239012831, 11419.37193454368, 11430.142739294752, 11652.184347095623, 11849.703757405789, 10723.142148627934, 11446.771064578828, 12039.0, 12039.157258991787, 12158.878411216128, 8990.415622984747, 9015.729528114167, 9344.439333640003, 9400.482973436254, 9434.716958491255, 10249.692509224735, 10265.2301077418, 10390.220733445172, 11437.256578322715, 11559.0], "value": 9435.454290197014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.746573082576, 1528.7095451864147, 1685.6628674265141, 1819.654265689518, 1840.9171587278572, 7949.205079492048, 8446.28206602438, 8453.323734101272, 8455.746327610173, 8457.492550446977, 7394.149672787631, 7599.392048636109, 7973.960130199355, 8119.147489513604, 8334.541600211985, 2410.7589241075884, 2436.805055595557, 2439.9024039038504, 2440.1947357372114, 2441.2310122311414, 2403.675503806981, 2430.1980346485707, 2431.6109422492405, 2437.2079074300837, 2445.4497738008986, 2136.476563242008, 2203.294945617403, 2206.646936490162, 2223.132978138527, 2309.180241014441, 2402.3633737059695, 2430.2344761400277, 2436.110819550869, 2441.8901149448316, 2447.143499775082, 2455.5683828229076, 2479.776820086201, 2496.4383013821925, 2496.6379874918216, 2500.1374525788574, 8284.130166332508, 8431.74704758852, 8437.409381343308, 8441.198086181803, 8449.535275559841, 5246.685198888079, 5369.167778994262, 5372.7313634318125, 5378.757955891994, 5388.78444862205, 3228.9677103229137, 3355.6644335566248, 3372.477266023746, 3405.1487128217946, 3412.0, 1070.2829104500004, 1111.1222134513725, 1117.9602969238606, 1128.1933417606451, 1145.301366166646, 11154.498047587878, 11168.553257869675, 11180.944095279552, 11235.382053987027, 11282.153838462065, 4743.739094349775, 4807.375041244686, 4852.223644216979, 4896.36347274852, 4962.950370496321, 9076.727698169065, 9142.0, 9142.3600347975, 9144.497052662035, 9150.130737579919, 5374.5700343972385, 5378.058839703036, 5378.354597448331, 5383.7308134593895, 5386.434424385383, 4804.351412559329, 4896.0, 4969.130402179604, 4971.577415919615, 5066.873328166826, 3714.2200137971327, 3772.962270377316, 3803.0682482791894, 3850.7111966602615, 3876.767393956315, 1171.1918776044502, 1183.4378670131618, 1196.6888608961558, 1218.9512419503299, 1221.2367270455966, 772.1776308231715, 806.9757907262791, 886.2068448738343, 956.5121787888227, 983.1299300119446, 5291.365036195682, 5331.360236771612, 5417.079096553595, 5462.672239665553, 5640.069388550925, 905.9728208153766, 949.1505102932837, 963.5182408795603, 968.1915600473683, 985.8176237396104, 3815.980920095382, 3859.1702783901596, 3929.4891664083484, 4006.8597599084474, 4024.3762216856435, 10212.897871021194, 10284.588616455258, 10427.426491542887, 10428.791424171626, 10437.165026797838, 10022.0, 10085.0, 10268.58925642966, 10278.17774578032, 10338.53476593555, 7557.4331925105835, 7712.190220026929, 7901.170377110436, 7953.840923181504, 7993.560354180576, 5426.375966763872, 5588.469095435927, 5738.454846789548, 5754.625949313281, 5763.711814409179, 9538.0, 9539.379940304136, 9569.665061722806, 9625.903740962502, 9717.17404020666, 9084.182423581646, 9434.716958491255, 9466.668666596635, 9658.034196580285, 9677.0, 7279.381252593377, 7337.523061001018, 7340.632968351668, 7348.669309881175, 7395.445341599294, 7865.60671966388, 7892.289693927574, 7898.407619428681, 7938.3563340847, 8033.758987230392, 7287.963560182166, 7354.8896766549615, 7370.815729606588, 7376.151742549461, 7487.850242995, 7194.316539928698, 7237.131544214517, 7270.163931147986, 7310.707571697072, 7503.66233519482, 6496.675166241764, 6508.869822603616, 6541.771038013837, 6565.376289252514, 6605.273419923708, 4856.927146092741, 4889.9022019560125, 4976.05361592893, 4989.775460104232, 5057.291979122852, 4783.976080119716, 4890.462049174517, 4916.975415122902, 4929.950700493093, 4969.577585905238], "value": 4502.836905348222, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.60420100080887, 348.38162261984974, 363.7217528590628, 363.9472276519903, 365.9231561372112, 5079.517445842648, 5235.9266350398175, 5325.62720609557, 5349.866253343668, 5366.543843773275, 5182.611304152185, 5214.06146893559, 5230.816921407742, 5291.126964050936, 5297.841064768054, 4186.790660466964, 4198.013466835291, 4201.1807697499, 4205.243056249874, 4231.815091774292, 4017.337139372015, 4108.77401742904, 4125.154343359604, 4135.31767258402, 4190.497140343163, 4073.287174744423, 4140.267423500491, 4145.5647157048525, 4157.937630935538, 4173.373993900909, 4137.834486620532, 4153.563875793058, 4162.458880345566, 4163.770992595406, 4184.958150418487, 3694.2796154749835, 3753.6621704046493, 3778.263238668461, 3784.2053168834577, 3791.2939177370295, 5084.694918304876, 5098.490150984871, 5106.391486681683, 5113.923291150636, 5120.385553733576, 4796.400449943757, 4810.230363141915, 4817.927731084036, 4824.300476430898, 4824.662273640846, 5231.424543300272, 5431.674099553999, 5534.723263836792, 5545.528630066449, 5560.913692900439, 4031.455753473302, 4041.5756345583586, 4042.797860106983, 4042.797860106983, 4058.5738497457637, 5642.984262832689, 5689.6586204827845, 5694.629849059839, 5709.942900570983, 5741.25363702716, 4069.2471892699355, 4133.152703695735, 4153.273177193979, 4157.8960525987095, 4184.163167366539, 4186.183694179666, 4197.496300443966, 4202.936955945664, 4223.092035212383, 4232.936505952413, 4508.887277818081, 4566.337881007302, 4576.0, 4689.671722979427, 4716.316134160527, 5485.31219702351, 5497.8075767347955, 5501.477359650827, 5522.91715624266, 5528.336599608073, 1388.6944872128115, 1409.9647508812157, 1425.7647488164337, 1425.8003879456885, 1428.2287564715145, 945.2674177512346, 956.3831328793028, 958.9664361747444, 966.8114717629994, 976.7216343342113, 5134.409542902539, 5140.948590514122, 5170.482951704799, 5174.689518628894, 5178.792848286102, 5425.782968681208, 5432.538234250054, 5463.754131064112, 5525.585581081435, 5543.916841247385, 5148.2277658350795, 5197.58419326453, 5424.294841670558, 5426.945730542723, 5438.401775804658, 2888.9277768055967, 2891.6385451818524, 2897.6812550619416, 2898.7246211609863, 2912.432075745209, 5615.719214039364, 5675.829725108253, 5686.829395118153, 5696.51579615729, 5697.886042279131, 5794.449527294901, 5808.970955145197, 5823.5341172706085, 5829.659178388994, 5846.1230815377185, 5886.205362276038, 5886.646801191942, 5905.025670764448, 5930.82700755094, 5942.257217847769, 5509.713468910518, 5665.546756259571, 5673.461021202979, 5701.258836351248, 5724.599278050497, 5599.244102046172, 5611.270534830446, 5611.382747897646, 5613.298337707786, 5628.465295796893, 5645.633033852787, 5889.204957330706, 5890.970545147246, 5906.725910524393, 5912.822615321547, 4119.0, 4152.584741525823, 4167.604077612622, 4172.415861779414, 4178.770167640809, 5443.428440013741, 5536.52939500147, 5567.972160139173, 5693.345265294379, 5738.741756620879, 5494.516480550309, 5575.9163612545035, 5594.636348637326, 5596.097326908871, 5605.0, 5528.115501519737, 5536.252605898152, 5558.221369161991, 5594.188842617717, 5600.607957443103, 5278.0, 5483.533899618577, 5532.75102620375, 5546.528545073714, 5550.777968881361, 5509.972450137724, 5594.272744543184, 5601.60788744784, 5606.411326810626, 5611.3266408031295, 5251.816186433456, 5449.7275136243825, 5464.28964234647, 5475.4250803665045, 5492.231087647652], "value": 4241.100543629077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.151209425679, 802.48239885274, 839.7480755773269, 840.6595328891793, 895.6014573514784, 14450.205238711867, 14554.63613409664, 14611.634709132277, 14658.999999999987, 14677.045992010511, 13992.580222593338, 14707.11757294563, 15151.62120946977, 15235.162066086361, 15815.130167840764, 721.2426951700719, 738.2211766586249, 843.1989609870632, 844.3203221406765, 867.4578388507183, 831.71721614651, 859.6948083430386, 860.0152825015354, 860.3461369359269, 860.9483430994129, 904.4030939579878, 906.3247880329164, 907.7458311672742, 909.3861643390718, 909.6952520905504, 743.9888401673979, 766.3026645752338, 898.7393655839832, 899.5637115998735, 899.9055099214554, 568.2215364950004, 644.3266786208424, 658.5554750543364, 659.9835004124935, 660.3792435111028, 13743.450261989608, 13845.861541384558, 13902.0, 13906.721865562633, 13917.164970101827, 13239.205647661074, 13351.198928064347, 13351.666208344868, 13429.0, 13489.527866524624, 11873.16887817853, 12080.758384832254, 12117.394130293538, 12267.57063502773, 12270.938645306805, 4467.128909862578, 4468.620167285784, 4472.0, 4511.503734589192, 4639.350490931272, 62661.686691566705, 63471.0, 63706.362936370504, 63949.360506394805, 65098.674506627634, 11136.610218642309, 11215.327080375204, 11413.771724565462, 11490.310581364978, 11522.193446458667, 20553.89723051375, 20562.177512899616, 20563.0, 20656.17375305001, 20772.169113235603, 8462.746117616482, 8482.10937851529, 8554.743357699279, 8784.692535761218, 8819.735407937773, 4754.548317909793, 4788.138135135709, 4816.181249187646, 4840.15297322967, 4867.318575399447, 3537.699295559906, 3651.6348365163803, 3665.120371110914, 3667.6149004354693, 3667.8166091695307, 637.6843462486006, 645.0614356111846, 654.254150268694, 664.0935123556311, 667.0461240426237, 603.6709993053709, 623.3735096228352, 704.8590281943632, 740.7703611880227, 775.2054144501818, 9533.380330278509, 9550.331476796557, 9729.659461918798, 9884.0, 10069.345492542961, 642.4731719989657, 643.6009674002148, 753.9773806785805, 767.5548182054395, 789.3724489031234, 4585.403897493305, 4611.9077618447445, 4782.569568738831, 4786.521347865186, 4843.878903027453, 51078.48921510737, 69290.0, 70453.94319085218, 90246.54876725575, 94804.15587532385, 78492.60753696195, 79460.60269698614, 80287.59856200681, 83262.58368708118, 83994.0, 71169.6441517789, 72117.63941180366, 73881.0, 74636.25363746293, 76980.61509692416, 9270.243351320785, 9553.761155970878, 9666.854997175189, 9678.612855485984, 9742.707718768448, 47681.0, 47820.760896195294, 48110.27834582554, 48936.75531622319, 49421.50578494169, 58774.7061264708, 63436.36563634305, 66214.0, 66748.0, 67899.0, 11384.772304553697, 11446.255993360404, 11480.827787583026, 11537.134714896583, 11593.478293476983, 12230.75538489243, 12260.693482663004, 12557.0, 12758.48966041348, 13117.344132793512, 11970.880291197325, 12553.560625378068, 12557.0, 12940.223586584834, 13145.34273286351, 11654.76690466169, 11744.354060526754, 11748.58879939198, 12036.157468977437, 12335.444904979118, 11960.820587691365, 12020.098492612915, 12215.877841221474, 12337.814932775836, 12697.55558555446, 10133.189344852246, 10244.334118282288, 10282.588696452358, 10548.314359566604, 10606.416647084176, 10415.270931034755, 10790.858008209449, 11040.723981900517, 11133.944330278297, 11184.0], "value": 7229.980266145995, "unit": "score"}], "name": "dromaeo_css", "value": 7300.473488168101, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 116.0, 152.0, 120.0, 121.0, 116.0, 117.0, 143.0, 117.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 159.0, 159.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 111.0, 77.0, 76.0, 75.0, 76.0, 107.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 118.0, 82.0, 82.0, 83.0, 108.0, 81.0, 81.0, 115.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 53.0, 50.0, 51.0, 52.0, 52.0, 51.0, 51.0, 51.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 59.0, 58.0, 59.0, 62.0, 60.0, 59.0, 59.0, 60.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 75.0, 75.0, 75.0, 81.0, 75.0, 75.0, 74.0, 75.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 130.0, 122.0, 130.0, 122.0, 121.0, 128.0, 123.0, 170.0, 123.0], "value": 129.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 155.0, 156.0, 156.0, 156.0, 156.0, 156.0, 155.0, 152.0], "value": 155.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 62.0, 64.0, 65.0, 62.0, 61.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1452.9, "alertThreshold": 2.0}]} 13:28:37 INFO - Return code: 0 13:28:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:28:37 INFO - # TBPL SUCCESS # 13:28:37 INFO - Running post-action listener: _resource_record_post_action 13:28:37 INFO - [mozharness: 2016-12-22 21:28:37.768133Z] Finished run-tests step (success) 13:28:37 INFO - Running post-run listener: _resource_record_post_run 13:28:37 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 466944; Write bytes: 365981696; Read time: 112; Write time: 336656 13:28:37 INFO - TinderboxPrint: CPU usage
12.9% 13:28:37 INFO - TinderboxPrint: I/O read bytes / time
466,944 / 112 13:28:37 INFO - TinderboxPrint: I/O write bytes / time
365,981,696 / 336,656 13:28:37 INFO - TinderboxPrint: CPU idle
8,281.8 (87.0%) 13:28:37 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 13:28:37 INFO - TinderboxPrint: Swap in / out
0 / 0 13:28:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118611968; Read time: 0; Write time: 96748 13:28:37 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 462848; Write bytes: 246120448; Read time: 96; Write time: 239876 13:28:38 INFO - Running post-run listener: _upload_blobber_files 13:28:38 INFO - Blob upload gear active. 13:28:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:28:38 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 13:28:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:28:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:28:38 INFO - (blobuploader) - INFO - Open directory for files ... 13:28:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:28:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:42 INFO - (blobuploader) - INFO - Done attempting. 13:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:43 INFO - (blobuploader) - INFO - Done attempting. 13:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:28:43 INFO - (blobuploader) - INFO - Done attempting. 13:28:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:28:43 INFO - Return code: 0 13:28:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:28:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:28:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b60b62eda3340ffc0b93127d813360baa33b231fad0e1f66fd4335ca2e93145bdbaa945c645ecbf311358613028baee5a37d6825d87d5c04dfe5d4a2512cf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a84bb473c0a9915c0233ea0f0acb459669ef08b687979d6ece9e585b6b97aaa99e23348d08bf2bae446b0d91cb8eefbf3f9830d72f869e9ceb1efcc64ef6ac8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec37cb29ca5f32a16a949e63bd054074a397fd8619a42e7a0c8c76ce3d1edd2504a71066ee2188892b6a063ed6ec474bd3f9be2c8ca5c9af4732d6ffbd402098"} 13:28:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:28:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:28:43 INFO - Contents: 13:28:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b60b62eda3340ffc0b93127d813360baa33b231fad0e1f66fd4335ca2e93145bdbaa945c645ecbf311358613028baee5a37d6825d87d5c04dfe5d4a2512cf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a84bb473c0a9915c0233ea0f0acb459669ef08b687979d6ece9e585b6b97aaa99e23348d08bf2bae446b0d91cb8eefbf3f9830d72f869e9ceb1efcc64ef6ac8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec37cb29ca5f32a16a949e63bd054074a397fd8619a42e7a0c8c76ce3d1edd2504a71066ee2188892b6a063ed6ec474bd3f9be2c8ca5c9af4732d6ffbd402098"} 13:28:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:28:43 INFO - Copying logs to upload dir... 13:28:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:28:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.306699 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-22 13:28:43.702167) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 13:28:43.705802) ========= 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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b60b62eda3340ffc0b93127d813360baa33b231fad0e1f66fd4335ca2e93145bdbaa945c645ecbf311358613028baee5a37d6825d87d5c04dfe5d4a2512cf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a84bb473c0a9915c0233ea0f0acb459669ef08b687979d6ece9e585b6b97aaa99e23348d08bf2bae446b0d91cb8eefbf3f9830d72f869e9ceb1efcc64ef6ac8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec37cb29ca5f32a16a949e63bd054074a397fd8619a42e7a0c8c76ce3d1edd2504a71066ee2188892b6a063ed6ec474bd3f9be2c8ca5c9af4732d6ffbd402098"} build_url:https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011858 build_url: 'https://queue.taskcluster.net/v1/task/fCE0_MRzQ3-l8c99UtCuyQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31b60b62eda3340ffc0b93127d813360baa33b231fad0e1f66fd4335ca2e93145bdbaa945c645ecbf311358613028baee5a37d6825d87d5c04dfe5d4a2512cf2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a84bb473c0a9915c0233ea0f0acb459669ef08b687979d6ece9e585b6b97aaa99e23348d08bf2bae446b0d91cb8eefbf3f9830d72f869e9ceb1efcc64ef6ac8e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec37cb29ca5f32a16a949e63bd054074a397fd8619a42e7a0c8c76ce3d1edd2504a71066ee2188892b6a063ed6ec474bd3f9be2c8ca5c9af4732d6ffbd402098"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-22 13:28:43.736861) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:28:43.737251) ========= 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=af724c981e2a0f424dbabf99000001e7-1482440812.135740-1399073752 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-22 13:28:43.822527) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 13:28:43.823494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-22 13:28:43.824222) ========= ========= Total master_lag: 0.18 =========