builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1483352996.4 results: success (0) buildid: 20170102004004 builduid: b73d55e85d124ab0956ae5e3a21c011b revision: 1458ff2725619c3db4b1dcb4f057f26a60208873 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.400341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.400835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.401197) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.457225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.457629) ========= 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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-02 02:29:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 72.8M=0s 2017-01-02 02:29:59 (72.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137218 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.626548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.626825) ========= 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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018971 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.683481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:56.683812) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1458ff2725619c3db4b1dcb4f057f26a60208873 --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 1458ff2725619c3db4b1dcb4f057f26a60208873 --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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-02 02:29:59,290 truncating revision to first 12 chars 2017-01-02 02:29:59,290 Setting DEBUG logging. 2017-01-02 02:29:59,290 attempt 1/10 2017-01-02 02:29:59,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1458ff272561?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 02:29:59,784 unpacking tar archive at: mozilla-aurora-1458ff272561/testing/mozharness/ program finished with exit code 0 elapsedTime=0.849888 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:57.550706) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:57.550976) ========= script_repo_revision: 1458ff2725619c3db4b1dcb4f057f26a60208873 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:57.551340) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:57.551645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 02:29:57.564155) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-02 02:29:57.564423) ========= /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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:30:00 INFO - MultiFileLogger online at 20170102 02:30:00 in /builds/slave/test 02:30:00 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 02:30:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:30:00 INFO - {'append_to_log': False, 02:30:00 INFO - 'base_work_dir': '/builds/slave/test', 02:30:00 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:30:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:30:00 INFO - 'branch': 'Mozilla-Aurora', 02:30:00 INFO - 'buildbot_json_path': 'buildprops.json', 02:30:00 INFO - 'config_files': ('talos/linux_config.py',), 02:30:00 INFO - 'default_actions': ('clobber', 02:30:00 INFO - 'read-buildbot-config', 02:30:00 INFO - 'download-and-extract', 02:30:00 INFO - 'populate-webroot', 02:30:00 INFO - 'create-virtualenv', 02:30:00 INFO - 'install', 02:30:00 INFO - 'run-tests'), 02:30:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:30:00 INFO - 'download_minidump_stackwalk': True, 02:30:00 INFO - 'download_symbols': 'ondemand', 02:30:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:30:00 INFO - 'tooltool.py': '/tools/tooltool.py', 02:30:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:30:00 INFO - '/tools/misc-python/virtualenv.py')}, 02:30:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:30:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:30:00 INFO - 'installer_path': 'installer.exe', 02:30:00 INFO - 'log_level': 'info', 02:30:00 INFO - 'log_name': 'talos', 02:30:00 INFO - 'log_to_console': True, 02:30:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:30:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:30:00 INFO - 'opt_config_files': (), 02:30:00 INFO - 'pip_index': False, 02:30:00 INFO - 'sps_profile': False, 02:30:00 INFO - 'sps_profile_interval': 0, 02:30:00 INFO - 'suite': 'dromaeojs', 02:30:00 INFO - 'system_bits': '32', 02:30:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:30:00 INFO - 'title': 'talos-linux64-ix-038', 02:30:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:30:00 INFO - 'use_talos_json': True, 02:30:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:30:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:30:00 INFO - 'work_dir': 'build'} 02:30:00 INFO - [mozharness: 2017-01-02 10:30:00.276046Z] Running clobber step. 02:30:00 INFO - Running pre-action listener: _resource_record_pre_action 02:30:00 INFO - Running main action method: clobber 02:30:00 INFO - rmtree: /builds/slave/test/build 02:30:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:30:00 INFO - Running post-action listener: _resource_record_post_action 02:30:00 INFO - [mozharness: 2017-01-02 10:30:00.744937Z] Finished clobber step (success) 02:30:00 INFO - [mozharness: 2017-01-02 10:30:00.745037Z] Running read-buildbot-config step. 02:30:00 INFO - Running pre-action listener: _resource_record_pre_action 02:30:00 INFO - Running main action method: read_buildbot_config 02:30:00 INFO - Using buildbot properties: 02:30:00 INFO - { 02:30:00 INFO - "project": "", 02:30:00 INFO - "product": "firefox", 02:30:00 INFO - "script_repo_revision": "production", 02:30:00 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:30:00 INFO - "repository": "", 02:30:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:30:00 INFO - "buildid": "20170102004004", 02:30:00 INFO - "stage_platform": "linux64-pgo", 02:30:00 INFO - "basedir": "/builds/slave/test", 02:30:00 INFO - "nightly_build": "True", 02:30:00 INFO - "buildnumber": 673, 02:30:00 INFO - "slavename": "talos-linux64-ix-038", 02:30:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:30:00 INFO - "platform": "ubuntu64_hw", 02:30:00 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:30:00 INFO - "branch": "mozilla-aurora", 02:30:00 INFO - "repo_path": "releases/mozilla-aurora", 02:30:00 INFO - "revision": "1458ff2725619c3db4b1dcb4f057f26a60208873", 02:30:00 INFO - "pgo_build": "True", 02:30:00 INFO - "builduid": "b73d55e85d124ab0956ae5e3a21c011b", 02:30:00 INFO - "slavebuilddir": "test" 02:30:00 INFO - } 02:30:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:30:00 INFO - Running post-action listener: _resource_record_post_action 02:30:00 INFO - [mozharness: 2017-01-02 10:30:00.747535Z] Finished read-buildbot-config step (success) 02:30:00 INFO - [mozharness: 2017-01-02 10:30:00.747623Z] Running download-and-extract step. 02:30:00 INFO - Running pre-action listener: _resource_record_pre_action 02:30:00 INFO - Running main action method: download_and_extract 02:30:00 INFO - mkdir: /builds/slave/test/build/tests 02:30:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:00 INFO - trying https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:30:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/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 02:30:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/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 02:30:01 INFO - Downloaded 1361 bytes. 02:30:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:30:01 INFO - Using the following test package requirements: 02:30:01 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:30:01 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:30:01 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:30:01 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'jsshell-linux-x86_64.zip'], 02:30:01 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:30:01 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:30:01 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:30:01 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:30:01 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:30:01 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:30:01 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:30:01 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:30:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:30:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:30:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:30:01 INFO - Http code: 200 02:30:01 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 02:30:01 INFO - x-amz-cf-id: ogg6cJEyVHtW4DOHK_5QDz0tfjnM_6wWv1uB5ODkedXh1I9YWmvJlg== 02:30:01 INFO - x-amz-version-id: ltcpBaeVv7uHEu8LlbCR7m5CtG7r8kZ4 02:30:02 INFO - Expected file size: 21941632 02:30:02 INFO - Obtained file size: 21941632 02:30:06 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 02:30:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:30:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:30:06 INFO - Fetch https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:30:06 INFO - Http code: 200 02:30:06 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 02:30:06 INFO - x-amz-cf-id: 15zkcQsUkiwUy5v79P8kNo-HEuvYgd1DaVa2oprFXNeO2UWCIhJ_6w== 02:30:06 INFO - x-amz-version-id: ltcpBaeVv7uHEu8LlbCR7m5CtG7r8kZ4 02:30:07 INFO - Expected file size: 21941632 02:30:07 INFO - Obtained file size: 21941632 02:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:30:12 INFO - Http code: 200 02:30:12 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 02:30:12 INFO - x-amz-cf-id: lk4bNYE_2k7mHNhUj42iCCBiNIzTIpR5dtLwh_wnlF6VsnYndd7pRQ== 02:30:12 INFO - x-amz-version-id: q8LITo4cBA9iUhCFlZfeoRdEQoot_6XH 02:30:13 INFO - Expected file size: 14409038 02:30:13 INFO - Obtained file size: 14409038 02:30:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:13 INFO - trying https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:30:13 INFO - Downloading https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/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 02:30:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/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 02:30:15 INFO - Downloaded 64012403 bytes. 02:30:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:30:15 INFO - mkdir: /builds/slave/test/properties 02:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 02:30:15 INFO - Contents: 02:30:15 INFO - build_url:https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:30:16 INFO - Running post-action listener: _resource_record_post_action 02:30:16 INFO - Running post-action listener: set_extra_try_arguments 02:30:16 INFO - [mozharness: 2017-01-02 10:30:16.521292Z] Finished download-and-extract step (success) 02:30:16 INFO - [mozharness: 2017-01-02 10:30:16.521557Z] Running populate-webroot step. 02:30:16 INFO - Running pre-action listener: _resource_record_pre_action 02:30:16 INFO - Running main action method: populate_webroot 02:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:30:16 INFO - '--tppagecycles', 02:30:16 INFO - '7'], 02:30:16 INFO - 'tests': ['tsvgm']}}, 02:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['damp', 'tps']}, 02:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'tests': ['damp', 'tps']}, 02:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['dromaeo_dom']}, 02:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:30:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['basic_compositor_video']}, 02:30:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['a11yr', 02:30:16 INFO - 'ts_paint', 02:30:16 INFO - 'tpaint', 02:30:16 INFO - 'sessionrestore', 02:30:16 INFO - 'sessionrestore_no_auto_restore', 02:30:16 INFO - 'tabpaint']}, 02:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['tsvgx', 02:30:16 INFO - 'tsvgr_opacity', 02:30:16 INFO - 'tart', 02:30:16 INFO - 'tscrollx', 02:30:16 INFO - 'cart']}, 02:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:30:16 INFO - 'tsvgr_opacity', 02:30:16 INFO - 'tart', 02:30:16 INFO - 'tscrollx', 02:30:16 INFO - 'cart']}, 02:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'talos_options': ['--disable-e10s'], 02:30:16 INFO - 'tests': ['tp5o']}, 02:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'tests': ['tp5o']}, 02:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'talos_options': ['--disable-e10s', 02:30:16 INFO - '--xperf_path', 02:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:16 INFO - 'tests': ['tp5n']}, 02:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:30:16 INFO - 'talos_options': ['--xperf_path', 02:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:30:16 INFO - 'tests': ['tp5n']}}, 02:30:16 INFO - 'talos.zip': {'path': '', 02:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:30:16 INFO - Running post-action listener: _resource_record_post_action 02:30:16 INFO - [mozharness: 2017-01-02 10:30:16.542331Z] Finished populate-webroot step (success) 02:30:16 INFO - [mozharness: 2017-01-02 10:30:16.542419Z] Running create-virtualenv step. 02:30:16 INFO - Running pre-action listener: _resource_record_pre_action 02:30:16 INFO - Running main action method: create_virtualenv 02:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 02:30:16 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 02:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:30:16 INFO - Using real prefix '/usr' 02:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:30:17 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:19 INFO - Installing pip.................done. 02:30:19 INFO - Return code: 0 02:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:30:19 INFO - Reading from file tmpfile_stdout 02:30:19 INFO - Output received: 02:30:19 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) 02:30:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:30:19 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')]} 02:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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')]} 02:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:19 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 02:30:19 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 02:30:19 INFO - Using env: {'DISPLAY': ':0', 02:30:19 INFO - 'HOME': '/home/cltbld', 02:30:19 INFO - 'LANG': 'en_US.UTF-8', 02:30:19 INFO - 'LANGUAGE': 'en_US:en', 02:30:19 INFO - 'LOGNAME': 'cltbld', 02:30:19 INFO - 'MAIL': '/var/mail/cltbld', 02:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:19 INFO - 'MOZ_NO_REMOTE': '1', 02:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:19 INFO - 'NO_EM_RESTART': '1', 02:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:19 INFO - 'PWD': '/builds/slave/test', 02:30:19 INFO - 'SHELL': '/bin/bash', 02:30:19 INFO - 'SHLVL': '1', 02:30:19 INFO - 'TERM': 'linux', 02:30:19 INFO - 'TMOUT': '86400', 02:30:19 INFO - 'USER': 'cltbld', 02:30:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:19 INFO - '_': '/tools/buildbot/bin/python'} 02:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:19 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 02:30:19 INFO - Cleaning up... 02:30:19 INFO - Return code: 0 02:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:30:19 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')]} 02:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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')]} 02:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:19 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 02:30:19 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 02:30:19 INFO - Using env: {'DISPLAY': ':0', 02:30:19 INFO - 'HOME': '/home/cltbld', 02:30:19 INFO - 'LANG': 'en_US.UTF-8', 02:30:19 INFO - 'LANGUAGE': 'en_US:en', 02:30:19 INFO - 'LOGNAME': 'cltbld', 02:30:19 INFO - 'MAIL': '/var/mail/cltbld', 02:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:19 INFO - 'MOZ_NO_REMOTE': '1', 02:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:19 INFO - 'NO_EM_RESTART': '1', 02:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:19 INFO - 'PWD': '/builds/slave/test', 02:30:19 INFO - 'SHELL': '/bin/bash', 02:30:19 INFO - 'SHLVL': '1', 02:30:19 INFO - 'TERM': 'linux', 02:30:19 INFO - 'TMOUT': '86400', 02:30:19 INFO - 'USER': 'cltbld', 02:30:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:19 INFO - '_': '/tools/buildbot/bin/python'} 02:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:19 INFO - Downloading/unpacking psutil>=3.1.1 02:30:19 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 02:30:19 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 02:30:19 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 02:30:19 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 02:30:19 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 02:30:19 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 02:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:21 INFO - Installing collected packages: psutil 02:30:21 INFO - Running setup.py install for psutil 02:30:21 INFO - building 'psutil._psutil_linux' extension 02:30:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:30:22 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 02:30:22 INFO - building 'psutil._psutil_posix' extension 02:30:22 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 02:30:22 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 02:30:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:22 INFO - Successfully installed psutil 02:30:22 INFO - Cleaning up... 02:30:22 INFO - Return code: 0 02:30:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:30:22 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')]} 02:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:22 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')]} 02:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:22 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:22 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 02:30:22 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 02:30:22 INFO - Using env: {'DISPLAY': ':0', 02:30:22 INFO - 'HOME': '/home/cltbld', 02:30:22 INFO - 'LANG': 'en_US.UTF-8', 02:30:22 INFO - 'LANGUAGE': 'en_US:en', 02:30:22 INFO - 'LOGNAME': 'cltbld', 02:30:22 INFO - 'MAIL': '/var/mail/cltbld', 02:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:22 INFO - 'MOZ_NO_REMOTE': '1', 02:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:22 INFO - 'NO_EM_RESTART': '1', 02:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:22 INFO - 'PWD': '/builds/slave/test', 02:30:22 INFO - 'SHELL': '/bin/bash', 02:30:22 INFO - 'SHLVL': '1', 02:30:22 INFO - 'TERM': 'linux', 02:30:22 INFO - 'TMOUT': '86400', 02:30:22 INFO - 'USER': 'cltbld', 02:30:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:22 INFO - '_': '/tools/buildbot/bin/python'} 02:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:30:24 INFO - Installing collected packages: mozsystemmonitor 02:30:24 INFO - Running setup.py install for mozsystemmonitor 02:30:24 INFO - Successfully installed mozsystemmonitor 02:30:24 INFO - Cleaning up... 02:30:24 INFO - Return code: 0 02:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:30:24 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')]} 02:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:24 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')]} 02:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:24 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:24 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 02:30:24 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 02:30:24 INFO - Using env: {'DISPLAY': ':0', 02:30:24 INFO - 'HOME': '/home/cltbld', 02:30:24 INFO - 'LANG': 'en_US.UTF-8', 02:30:24 INFO - 'LANGUAGE': 'en_US:en', 02:30:24 INFO - 'LOGNAME': 'cltbld', 02:30:24 INFO - 'MAIL': '/var/mail/cltbld', 02:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:24 INFO - 'MOZ_NO_REMOTE': '1', 02:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:24 INFO - 'NO_EM_RESTART': '1', 02:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:24 INFO - 'PWD': '/builds/slave/test', 02:30:24 INFO - 'SHELL': '/bin/bash', 02:30:24 INFO - 'SHLVL': '1', 02:30:24 INFO - 'TERM': 'linux', 02:30:24 INFO - 'TMOUT': '86400', 02:30:24 INFO - 'USER': 'cltbld', 02:30:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:24 INFO - '_': '/tools/buildbot/bin/python'} 02:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:25 INFO - Downloading/unpacking jsonschema==2.5.1 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:27 INFO - warning: no files found matching '*.txt' 02:30:27 INFO - no previously-included directories found matching 'build' 02:30:27 INFO - no previously-included directories found matching 'dist' 02:30:27 INFO - no previously-included directories found matching '.git*' 02:30:27 INFO - Installing collected packages: jsonschema, functools32 02:30:27 INFO - Running setup.py install for functools32 02:30:27 INFO - warning: no files found matching '*.txt' 02:30:27 INFO - no previously-included directories found matching 'build' 02:30:27 INFO - no previously-included directories found matching 'dist' 02:30:27 INFO - no previously-included directories found matching '.git*' 02:30:27 INFO - Successfully installed jsonschema functools32 02:30:27 INFO - Cleaning up... 02:30:27 INFO - Return code: 0 02:30:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:30:27 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')]} 02:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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')]} 02:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:27 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 02:30:27 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 02:30:27 INFO - Using env: {'DISPLAY': ':0', 02:30:27 INFO - 'HOME': '/home/cltbld', 02:30:27 INFO - 'LANG': 'en_US.UTF-8', 02:30:27 INFO - 'LANGUAGE': 'en_US:en', 02:30:27 INFO - 'LOGNAME': 'cltbld', 02:30:27 INFO - 'MAIL': '/var/mail/cltbld', 02:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:27 INFO - 'MOZ_NO_REMOTE': '1', 02:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:27 INFO - 'NO_EM_RESTART': '1', 02:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:27 INFO - 'PWD': '/builds/slave/test', 02:30:27 INFO - 'SHELL': '/bin/bash', 02:30:27 INFO - 'SHLVL': '1', 02:30:27 INFO - 'TERM': 'linux', 02:30:27 INFO - 'TMOUT': '86400', 02:30:27 INFO - 'USER': 'cltbld', 02:30:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:27 INFO - '_': '/tools/buildbot/bin/python'} 02:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:30:27 INFO - Cleaning up... 02:30:27 INFO - Return code: 0 02:30:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:30:27 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')]} 02:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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')]} 02:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:27 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:27 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 02:30:27 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 02:30:27 INFO - Using env: {'DISPLAY': ':0', 02:30:27 INFO - 'HOME': '/home/cltbld', 02:30:27 INFO - 'LANG': 'en_US.UTF-8', 02:30:27 INFO - 'LANGUAGE': 'en_US:en', 02:30:27 INFO - 'LOGNAME': 'cltbld', 02:30:27 INFO - 'MAIL': '/var/mail/cltbld', 02:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:27 INFO - 'MOZ_NO_REMOTE': '1', 02:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:27 INFO - 'NO_EM_RESTART': '1', 02:30:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:27 INFO - 'PWD': '/builds/slave/test', 02:30:27 INFO - 'SHELL': '/bin/bash', 02:30:27 INFO - 'SHLVL': '1', 02:30:27 INFO - 'TERM': 'linux', 02:30:27 INFO - 'TMOUT': '86400', 02:30:27 INFO - 'USER': 'cltbld', 02:30:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:27 INFO - '_': '/tools/buildbot/bin/python'} 02:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:27 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 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 02:30:30 INFO - Downloading docopt-0.6.1.tar.gz 02:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:30 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:30 INFO - Running setup.py install for blobuploader 02:30:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:30:30 INFO - Running setup.py install for requests 02:30:31 INFO - Running setup.py install for docopt 02:30:31 INFO - Successfully installed blobuploader requests docopt 02:30:31 INFO - Cleaning up... 02:30:31 INFO - Return code: 0 02:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:31 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')]} 02:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:31 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')]} 02:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:31 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:31 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 02:30:31 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 02:30:31 INFO - Using env: {'DISPLAY': ':0', 02:30:31 INFO - 'HOME': '/home/cltbld', 02:30:31 INFO - 'LANG': 'en_US.UTF-8', 02:30:31 INFO - 'LANGUAGE': 'en_US:en', 02:30:31 INFO - 'LOGNAME': 'cltbld', 02:30:31 INFO - 'MAIL': '/var/mail/cltbld', 02:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:31 INFO - 'MOZ_NO_REMOTE': '1', 02:30:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:31 INFO - 'NO_EM_RESTART': '1', 02:30:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:31 INFO - 'PWD': '/builds/slave/test', 02:30:31 INFO - 'SHELL': '/bin/bash', 02:30:31 INFO - 'SHLVL': '1', 02:30:31 INFO - 'TERM': 'linux', 02:30:31 INFO - 'TMOUT': '86400', 02:30:31 INFO - 'USER': 'cltbld', 02:30:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:31 INFO - '_': '/tools/buildbot/bin/python'} 02:30:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:31 INFO - Running setup.py (path:/tmp/pip-A2NajE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:31 INFO - Running setup.py (path:/tmp/pip-ZGjUwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:31 INFO - Running setup.py (path:/tmp/pip-IBoI0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:31 INFO - Running setup.py (path:/tmp/pip-KzxL_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:31 INFO - Running setup.py (path:/tmp/pip-GyTPc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:31 INFO - Running setup.py (path:/tmp/pip-1iJey4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:32 INFO - Running setup.py (path:/tmp/pip-DF1qlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:32 INFO - Running setup.py (path:/tmp/pip-ZyurWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:32 INFO - Running setup.py (path:/tmp/pip-gF4rfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:32 INFO - Running setup.py (path:/tmp/pip-blofKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:32 INFO - Running setup.py (path:/tmp/pip-shqorl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:32 INFO - Running setup.py (path:/tmp/pip-TnYeQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:32 INFO - Running setup.py (path:/tmp/pip-_D7SY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:32 INFO - Running setup.py (path:/tmp/pip-EsEAa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:32 INFO - Running setup.py (path:/tmp/pip-TXeLti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:32 INFO - Running setup.py (path:/tmp/pip-kIo6Ta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:32 INFO - Running setup.py (path:/tmp/pip-kRvoSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:32 INFO - Running setup.py install for manifestparser 02:30:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:30:32 INFO - Running setup.py install for mozcrash 02:30:33 INFO - Running setup.py install for mozdebug 02:30:33 INFO - Running setup.py install for mozdevice 02:30:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Running setup.py install for mozfile 02:30:33 INFO - Running setup.py install for mozhttpd 02:30:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Running setup.py install for mozinfo 02:30:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Running setup.py install for mozInstall 02:30:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Running setup.py install for mozleak 02:30:33 INFO - Running setup.py install for mozlog 02:30:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:30:33 INFO - Running setup.py install for moznetwork 02:30:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Running setup.py install for mozprocess 02:30:34 INFO - Running setup.py install for mozprofile 02:30:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Running setup.py install for mozrunner 02:30:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Running setup.py install for mozscreenshot 02:30:34 INFO - Running setup.py install for moztest 02:30:34 INFO - Running setup.py install for mozversion 02:30:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:30:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:34 INFO - Cleaning up... 02:30:34 INFO - Return code: 0 02:30:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:34 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')]} 02:30:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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')]} 02:30:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:34 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:34 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 02:30:34 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 02:30:34 INFO - Using env: {'DISPLAY': ':0', 02:30:34 INFO - 'HOME': '/home/cltbld', 02:30:34 INFO - 'LANG': 'en_US.UTF-8', 02:30:34 INFO - 'LANGUAGE': 'en_US:en', 02:30:34 INFO - 'LOGNAME': 'cltbld', 02:30:34 INFO - 'MAIL': '/var/mail/cltbld', 02:30:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:34 INFO - 'MOZ_NO_REMOTE': '1', 02:30:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:34 INFO - 'NO_EM_RESTART': '1', 02:30:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:34 INFO - 'PWD': '/builds/slave/test', 02:30:34 INFO - 'SHELL': '/bin/bash', 02:30:34 INFO - 'SHLVL': '1', 02:30:34 INFO - 'TERM': 'linux', 02:30:34 INFO - 'TMOUT': '86400', 02:30:34 INFO - 'USER': 'cltbld', 02:30:34 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:34 INFO - '_': '/tools/buildbot/bin/python'} 02:30:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:30:34 INFO - Running setup.py (path:/tmp/pip-oRf6rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:30:35 INFO - Running setup.py (path:/tmp/pip-E_oF7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:30:35 INFO - Running setup.py (path:/tmp/pip-DO1apV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:30:35 INFO - Running setup.py (path:/tmp/pip-KQ1EhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:30:35 INFO - Running setup.py (path:/tmp/pip-4pqnjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:30:35 INFO - Running setup.py (path:/tmp/pip-nFJDuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:30:35 INFO - Running setup.py (path:/tmp/pip-WH9S2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:30:35 INFO - Running setup.py (path:/tmp/pip-fgXqWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:30:35 INFO - Running setup.py (path:/tmp/pip-lfskmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:30:35 INFO - Running setup.py (path:/tmp/pip-hYZ7sD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:30:35 INFO - Running setup.py (path:/tmp/pip-3JE0Ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:30:35 INFO - Running setup.py (path:/tmp/pip-82dssX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:30:35 INFO - Running setup.py (path:/tmp/pip-mMuqH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:30:35 INFO - Running setup.py (path:/tmp/pip-KeCCmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:30:35 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)) 02:30:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:35 INFO - Running setup.py (path:/tmp/pip-KnXbfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:30:36 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)) 02:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:30:36 INFO - Running setup.py (path:/tmp/pip-_7e1ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:30:36 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)) 02:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:30:36 INFO - Running setup.py (path:/tmp/pip-9gPbtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 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)) 02:30:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:38 INFO - Downloading blessings-1.6.tar.gz 02:30:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:38 INFO - Installing collected packages: blessings 02:30:38 INFO - Running setup.py install for blessings 02:30:38 INFO - Successfully installed blessings 02:30:38 INFO - Cleaning up... 02:30:38 INFO - Return code: 0 02:30:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:38 INFO - Reading from file tmpfile_stdout 02:30:38 INFO - Current package versions: 02:30:38 INFO - argparse == 1.2.1 02:30:38 INFO - blessings == 1.6 02:30:38 INFO - blobuploader == 1.2.4 02:30:38 INFO - docopt == 0.6.1 02:30:38 INFO - functools32 == 3.2.3-2 02:30:38 INFO - jsonschema == 2.5.1 02:30:38 INFO - manifestparser == 1.1 02:30:38 INFO - mozInstall == 1.12 02:30:38 INFO - mozcrash == 1.0 02:30:38 INFO - mozdebug == 0.1 02:30:38 INFO - mozdevice == 0.48 02:30:38 INFO - mozfile == 1.2 02:30:38 INFO - mozhttpd == 0.7 02:30:38 INFO - mozinfo == 0.9 02:30:38 INFO - mozleak == 0.1 02:30:38 INFO - mozlog == 3.4 02:30:38 INFO - moznetwork == 0.27 02:30:38 INFO - mozprocess == 0.23 02:30:38 INFO - mozprofile == 0.28 02:30:38 INFO - mozrunner == 6.13 02:30:38 INFO - mozscreenshot == 0.1 02:30:38 INFO - mozsystemmonitor == 0.3 02:30:38 INFO - moztest == 0.7 02:30:38 INFO - mozversion == 1.4 02:30:38 INFO - psutil == 3.1.1 02:30:38 INFO - requests == 1.2.3 02:30:38 INFO - wsgiref == 0.1.2 02:30:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:30:38 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')]} 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 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')]} 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:38 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 02:30:38 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 02:30:38 INFO - Using env: {'DISPLAY': ':0', 02:30:38 INFO - 'HOME': '/home/cltbld', 02:30:38 INFO - 'LANG': 'en_US.UTF-8', 02:30:38 INFO - 'LANGUAGE': 'en_US:en', 02:30:38 INFO - 'LOGNAME': 'cltbld', 02:30:38 INFO - 'MAIL': '/var/mail/cltbld', 02:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:38 INFO - 'MOZ_NO_REMOTE': '1', 02:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:38 INFO - 'NO_EM_RESTART': '1', 02:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:38 INFO - 'PWD': '/builds/slave/test', 02:30:38 INFO - 'SHELL': '/bin/bash', 02:30:38 INFO - 'SHLVL': '1', 02:30:38 INFO - 'TERM': 'linux', 02:30:38 INFO - 'TMOUT': '86400', 02:30:38 INFO - 'USER': 'cltbld', 02:30:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:38 INFO - '_': '/tools/buildbot/bin/python'} 02:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 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)) 02:30:38 INFO - Cleaning up... 02:30:38 INFO - Return code: 0 02:30:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:30:38 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')]} 02:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 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')]} 02:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:38 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 0x7f0945ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28968a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2963ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, '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': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', '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 02:30:38 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 02:30:38 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 02:30:38 INFO - Using env: {'DISPLAY': ':0', 02:30:38 INFO - 'HOME': '/home/cltbld', 02:30:38 INFO - 'LANG': 'en_US.UTF-8', 02:30:38 INFO - 'LANGUAGE': 'en_US:en', 02:30:38 INFO - 'LOGNAME': 'cltbld', 02:30:38 INFO - 'MAIL': '/var/mail/cltbld', 02:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:38 INFO - 'MOZ_NO_REMOTE': '1', 02:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:38 INFO - 'NO_EM_RESTART': '1', 02:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:38 INFO - 'PWD': '/builds/slave/test', 02:30:38 INFO - 'SHELL': '/bin/bash', 02:30:38 INFO - 'SHLVL': '1', 02:30:38 INFO - 'TERM': 'linux', 02:30:38 INFO - 'TMOUT': '86400', 02:30:38 INFO - 'USER': 'cltbld', 02:30:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:38 INFO - '_': '/tools/buildbot/bin/python'} 02:30:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:30:39 INFO - Cleaning up... 02:30:39 INFO - Return code: 0 02:30:39 INFO - Running post-action listener: _resource_record_post_action 02:30:39 INFO - Running post-action listener: _start_resource_monitoring 02:30:39 INFO - Starting resource monitoring. 02:30:39 INFO - [mozharness: 2017-01-02 10:30:39.143890Z] Finished create-virtualenv step (success) 02:30:39 INFO - [mozharness: 2017-01-02 10:30:39.144392Z] Running install step. 02:30:39 INFO - Running pre-action listener: _resource_record_pre_action 02:30:39 INFO - Running main action method: install 02:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:30:39 INFO - Reading from file tmpfile_stdout 02:30:39 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:30:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:30:39 INFO - Reading from file tmpfile_stdout 02:30:39 INFO - Output received: 02:30:39 INFO - Usage: mozinstall [options] installer 02:30:39 INFO - Options: 02:30:39 INFO - -h, --help show this help message and exit 02:30:39 INFO - -d DEST, --destination=DEST 02:30:39 INFO - Directory to install application into. [default: 02:30:39 INFO - "/builds/slave/test"] 02:30:39 INFO - --app=APP Application being installed. [default: firefox] 02:30:39 INFO - mkdir: /builds/slave/test/build/application 02:30:39 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'] 02:30:39 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 02:30:55 INFO - Reading from file tmpfile_stdout 02:30:55 INFO - Output received: 02:30:55 INFO - /builds/slave/test/build/application/firefox/firefox 02:30:55 INFO - Running post-action listener: _resource_record_post_action 02:30:55 INFO - [mozharness: 2017-01-02 10:30:55.367935Z] Finished install step (success) 02:30:55 INFO - [mozharness: 2017-01-02 10:30:55.368176Z] Running run-tests step. 02:30:55 INFO - Running pre-action listener: _resource_record_pre_action 02:30:55 INFO - Running main action method: run_tests 02:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:55 INFO - Python 2.7.3 02:30:55 INFO - Return code: 0 02:30:55 INFO - grabbing minidump binary from tooltool 02:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:30:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2960f60>, '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 0x2961d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29621d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:30:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:30:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:55 INFO - Return code: 0 02:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:55 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/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:30:55 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/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 02:30:55 INFO - Using env: {'DISPLAY': ':0', 02:30:55 INFO - 'HOME': '/home/cltbld', 02:30:55 INFO - 'LANG': 'en_US.UTF-8', 02:30:55 INFO - 'LANGUAGE': 'en_US:en', 02:30:55 INFO - 'LOGNAME': 'cltbld', 02:30:55 INFO - 'MAIL': '/var/mail/cltbld', 02:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:55 INFO - 'MOZ_NO_REMOTE': '1', 02:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:55 INFO - 'NO_EM_RESTART': '1', 02:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:55 INFO - 'PWD': '/builds/slave/test', 02:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:55 INFO - 'SHELL': '/bin/bash', 02:30:55 INFO - 'SHLVL': '1', 02:30:55 INFO - 'TERM': 'linux', 02:30:55 INFO - 'TMOUT': '86400', 02:30:55 INFO - 'USER': 'cltbld', 02:30:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345', 02:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:55 INFO - '_': '/tools/buildbot/bin/python'} 02:30:55 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/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:30:55 INFO - mozversion application_buildid: 20170102004004 02:30:55 INFO - mozversion application_changeset: 1458ff2725619c3db4b1dcb4f057f26a60208873 02:30:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:55 INFO - mozversion application_name: Firefox 02:30:55 INFO - mozversion application_remotingname: firefox-dev 02:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:55 INFO - mozversion application_vendor: Mozilla 02:30:55 INFO - mozversion application_version: 52.0a2 02:30:55 INFO - mozversion platform_buildid: 20170102004004 02:30:55 INFO - mozversion platform_changeset: 1458ff2725619c3db4b1dcb4f057f26a60208873 02:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:55 INFO - mozversion platform_version: 52.0a2 02:30:55 INFO - using testdate: 1483353055 02:30:55 INFO - actual date: 1483353055 02:30:55 INFO - starting webserver on 'localhost:39113' 02:30:55 INFO - SUITE-START | Running 2 tests 02:30:55 INFO - TEST-START | dromaeo_css 02:30:55 INFO - operating with platform_type : linux_ 02:30:55 INFO - Initialising browser for dromaeo_css test... 02:30:55 INFO - TEST-INFO | started process 20758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5RLFP/profile http://localhost:39113/getInfo.html) 02:31:00 INFO - PROCESS | 20758 | __metrics Screen width/height:1600/1200 02:31:00 INFO - PROCESS | 20758 | colorDepth:24 02:31:00 INFO - PROCESS | 20758 | Browser inner width/height: 1024/697 02:31:00 INFO - PROCESS | 20758 | __metrics 02:31:01 INFO - PROCESS | 20758 | 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" 02:31:01 INFO - PROCESS | 20758 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:31:02 INFO - PROCESS | 20758 | console.error: PushService: 02:31:02 INFO - PROCESS | 20758 | stateChangeProcessEnqueue: Error transitioning state 02:31:02 INFO - PROCESS | 20758 | UnknownError 02:31:02 INFO - TEST-INFO | 20758: exit 0 02:31:02 INFO - Browser initialized. 02:31:02 INFO - Running cycle 1/1 for dromaeo_css test... 02:31:02 INFO - TEST-INFO | started process 20850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5RLFP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:14 INFO - PROCESS | 20850 | RSS: Main: 148246528 02:31:14 INFO - PROCESS | 20850 | 02:32:05 INFO - PROCESS | 20850 | 1483353125173 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] 02:34:16 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39113/tests/dromaeo/cssquery-ext.html) 02:34:18 INFO - PROCESS | 20850 | RSS: Main: 266645504 02:34:18 INFO - PROCESS | 20850 | 02:37:20 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-ext.html (next: http://localhost:39113/tests/dromaeo/cssquery-jquery.html) 02:37:20 INFO - PROCESS | 20850 | RSS: Main: 230084608 02:37:20 INFO - PROCESS | 20850 | 02:40:22 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39113/tests/dromaeo/cssquery-mootools.html) 02:40:23 INFO - PROCESS | 20850 | RSS: Main: 220315648 02:40:23 INFO - PROCESS | 20850 | 02:43:25 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39113/tests/dromaeo/cssquery-prototype.html) 02:43:26 INFO - PROCESS | 20850 | RSS: Main: 216608768 02:43:26 INFO - PROCESS | 20850 | 02:46:28 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39113/tests/dromaeo/cssquery-yui.html) 02:46:29 INFO - PROCESS | 20850 | RSS: Main: 175534080 02:46:29 INFO - PROCESS | 20850 | 02:49:31 INFO - PROCESS | 20850 | Cycle 1(1): loaded http://localhost:39113/tests/dromaeo/cssquery-yui.html (next: http://localhost:39113/tests/dromaeo/cssquery-dojo.html) 02:49:32 INFO - PROCESS | 20850 | RSS: Main: 261951488 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | __start_tp_report 02:49:32 INFO - PROCESS | 20850 | _x_x_mozilla_page_load 02:49:32 INFO - PROCESS | 20850 | _x_x_mozilla_page_load_details 02:49:32 INFO - PROCESS | 20850 | |i|pagename|runs| 02:49:32 INFO - PROCESS | 20850 | |0;dojo.html;3220.855061522231;3253.4469140246165;3268.6077670679524;3285.490748933916;3304.09137487191;5468.371137319209;5591.692456914868;5609.607327487078;5612;5622.690752008638;5561.972190139054;5627.155926611;5631.746571404286;5648.293963254593;5666.801661941822;5068.1384164692;5084.161113416282;5108.5913126949945;5141.640085194038;5159.122949098643;4976.751162441881;4995.650304478688;5168.302279192318;5183.559397451221;5188.948110518903;5006.098902197603;5011.599072074244;5104.2088476286235;5126.948730512684;5148.819791307305;5071.2900193973055;5075.6447048706605;5146.330976972969;5150.742462876841;5180.352455943007;4829.251466022772;5024.598032157455;5043.621728370387;5083.79664813407;5109.718965456898;5370.7046112463795;5442.374126975369;5487.039768040577;5498.477644623795;5514.283143191399;5964.075568286922;6034.879302413971;6049.909251361233;6050.152978583002;6053.273607167168;5883.411658834125;6085.574009819315;6090.26916769986;6102.450779429828;6110.633361998294;5521.806736764234;5590.049691552405;5639.407862174413;5646.435356464321;5660.886782264414;6166.938330616636;6171.382861713792;6174.25908890936;6180.505559555225;6204.472619827366;5747.109198074305;5982.820515384546;5995.190649262294;5999.370066143079;5999.880002399927;5873.3832947539895;5918.674472904032;5961.552883533753;5963.194968679173;6065;5995.61028533144;6004.969975150184;6005.669688167105;6010.128531362928;6051.576389652682;5964.135200395918;5976.970115149396;5978.850528736816;6005.879882402415;6017.247844019497;4591.242444996538;4613.677042606985;4616.515265897099;4669.299605059268;4676.672632915664;4143.97928010358;4167.374893765959;4181.874543763692;4191.517975432865;4197.181549597799;5636.323641163087;5682.119271512922;5705.942940570624;5713.514351280104;5726.742296596663;5999.850003749942;6052.485538729257;6054.969725151346;6068.605540639845;6091;5709.543236541067;5714.314282286152;5715.657060576379;5726.599138060295;5738.885222295531;4991.226359914219;5051.040302342543;5116.744162791845;5129.666571672829;5138.4604616514725;6068.908966365508;6153.7230824613;6158.168647232746;6160.229971253593;6163.630182189083;6060.212172417558;6068.696565171812;6072.453479186895;6087.786927457518;6100.725467353891;5986.790462333797;6139.631622102688;6145.539084568586;6150.600210986271;6157.199564056823;5805.332386775575;5857.970710146422;5865.912011319919;5880.117982302518;6011.699415029144;6146.508279337553;6152.200213972334;6155.2921414037955;6157.72290246931;6158.507319414526;5951.940480595312;5999.70001499932;6019.849503762441;6025.096235564701;6027.849303767441;5729.799457018984;5780.450857168562;5901.91147132802;5944.256967879015;5946.613470124428;5963.671998040149;5969.462748352669;5975.701214939322;5978.7608495661425;5982.4316689914385;6025.548083893638;6040.909386359296;6042.8791424170395;6043.516518678583;6050.30421501533;5457.645253058538;5699.658020518782;5721.57088218377;5743.052396354555;5887.911681324869 02:49:32 INFO - PROCESS | 20850 | |1;ext.html;590.7016956436998;622.8909940760367;656.1470088884452;657.9210494740632;658.4798009572437;33463;43595.34606980894;44455.55544444555;44474.77762611186;44512.777436112854;44800.32799508002;45356;45391;45447.318290225674;45503.31745023819;8751.993520745116;8897.644094236222;8905.198532132106;8906.242969347613;8911.331650126234;8726.171013753683;8806.119388061175;8812.074732153127;8821.691240806573;8824.117588241157;8796.120387961217;8821.779455513632;8874.467531948103;8875.68935087272;8879.556022198896;8801.735947921541;8832.205101540892;8846.955765221164;8849.734507964738;8855;8733.650653973833;8744.562771861381;8759.34304927133;8813.338999575057;8818.86771698425;43030.35454468154;43188;43248.56751432477;43481.13037739259;43490.34764478535;3574.267275208576;3604.891853244407;3626.2928728897878;3690.538682664667;3809.3333666608232;32648.347033059206;32821.01536953895;33059.33881322384;33284;33373.6662633373;4433.334999750031;4449.399331090293;4479.081788233437;4501.729896206238;4578.633709303248;514991;515680;517058;519166;521912;63909;64454.355456444835;64566.677166614805;64584.677076614316;64595.35404645988;39076.41385379222;67847.32152678509;68160.31839681539;68188;68196.6590167046;17813.19840607176;18413.81586184121;18419;18432.63134737298;18539.90730046368;14079.296035198198;14212.43150273998;14225.573232803032;14230.14619122856;14628.853711462962;20214.58497905162;20384.89807550953;20431;20470.795292047187;20618.072186751633;7320.926790732131;7386.224446433154;7562.697492100255;7599.048494782793;7662.195469475736;959.2182371367313;993.64228877604;1058.8147074262126;1122.5790328626765;1142.354569668135;30684.693153068183;33245.50131748026;33328.83335583306;33387.83306083454;33558;1153.6250718516517;1168.2348062019391;1169.7368092179192;1172.8475298211179;1274.2800317820402;16243.593910152103;17179.570510737332;17236.224369903386;17513.12434378276;17591.120443978005;533166;537252;538207;538386;541093;61588.38411615916;61888.381116189164;61966.38033619606;61989;62110.37889621136;1328.5881376773232;1364.9931750341184;1414.165642271065;1463.0636392708675;1476.2471139718607;31238.531422029144;35309;35451.83466828624;35740.82129589335;35777.28445431025;52023.739881301866;52593.47406526039;52690.20964685609;52796.73601631967;52797.472025279254;406040;407953;408669;410674;411540;29351.55972660369;30450.543241851832;30564;30574.694253057183;30617.846910765304;49643.25535116904;49658.255126172415;49857.25214121864;49960;51104.233436497736;41094.38358424566;41710.374344384254;42123.57876421197;42271.78864105783;43911.34132988071;40808.18383632251;41837.372439414044;42868.35697464478;43063.784681076395;43216.35175472433;42465.787671061444;43241.35137972996;44066.55933440624;44116.33825492684;44405.33391999187;35354;37234.62765372312;37313.44029839609;37836.81081594574;37910.810445947594;29404.852975734986;29544.113676589735;29592.40815183641;29609.555856661736;29732 02:49:32 INFO - PROCESS | 20850 | |2;jquery.html;397.9363301871701;429.6605681511606;437.3090516983167;441.94917584477787;442.9313456414255;15807.525774226777;18999.240030398785;19748.605027899433;20699.379018629428;20856.165753369845;19173.712394314098;19849.70225446616;20181.495462613442;20379;20521.486962825937;5811.535077193825;6023.488003519706;6029.969850150743;6030.819075427722;6035;5577.191307260445;5837.824865254049;5887.735051922674;5893.292804863422;5902.822915312548;5664.433556644344;5851.473367396933;5858.677772722499;5861.589688721791;5863.970680146594;5776.075827867542;5780.826575202751;5804.1293805929445;5812.88374232513;5815.331236907747;5210.817621383233;5237.109691352479;5258.000979813862;5276.498732620395;5277.577793776527;23311.300660980196;23360.64959025616;23460;23468.413289667726;23636.054557817668;2471.270975062361;2509.623556466526;2572.498362819251;2697.5144473994674;2908.1566345759707;14947.177905215209;15068.623284417868;15141.318640661197;15251.61870953224;15440.150791706452;1995.0623207092642;2007.708882212071;2009.5578972626;2033.2680235115347;2053.5995480881234;81652.59173704153;83325;84369.57815210946;85647;85964;9995.70012899614;11044.116470682326;11113.55501789605;11235.943820280847;11289.322640641587;14077.296135193199;14741.852581474262;14775.556733297803;14806.703865922622;14841.851581484047;8174.305184059422;8346.290565301895;8365.330773538102;8535.871961920577;8576.699815506427;8069.435139540175;8075.676972921017;8208.917910820815;8233.876491852627;8262;6932.445404367639;7002.75490357835;7036.577805331696;7091.60996145217;7120.465965052642;1998.4803950972853;2089.853710240269;2108.599366120432;2119.809217170462;2132.829373650104;984.2716389871587;1041.9166466682648;1045.0536447613058;1057.7632444719184;1080.6226302135333;20185.192592296145;20468.18127274922;20771.58456830855;20808.47978800542;20862.165513379598;1052.594751020847;1075.113320733832;1080.448971024783;1108.4956344863067;1120;11064.391458469861;11716.589919352782;11805.468753906094;12032.87967120335;12084.456199471046;500931;503592;504985;522407;524807;51636.48363516392;63990;81127;82809.58595206986;83668.58165709133;1022.5347466902541;1042.2131290875493;1050.1074087025968;1055.7466208110152;1057.1225882517492;17683;18172.545686357946;18203.180856861738;18641.254349825856;18871.622567548846;40582.79708601556;41193;41478;42032;42148.57851421569;53962.19056714231;54025.45974540204;54371.18443223276;56024.719876400355;56214.43785562092;8589.742307730778;8960.417572858005;9008;9065.27477801761;9197.08029197075;13174;13188.208707477583;13231.80152297697;13572.457101716216;13721.313934303045;10277;10916.399598022184;11019.338839669324;11784.41077946082;11899.286042837457;11395.088392928712;11601.883981160418;11745.823812642988;12008.099392545419;12018.699532511408;11323.547058117912;11619.535218591162;11672.358020308964;11835.526578936746;12105.878941210474;7859.882101768364;8267.090620031671;8306.418550701394;8485.236328730443;9094.999550049622;9241.075892410705;10914.617988370368;11416.82874756896;11466.197366184288;11632.651020469399 02:49:32 INFO - PROCESS | 20850 | |3;mootools.html;1435;1478.47514132483;1535.02525896056;1714.9914250428747;1860.162926682992;7589.658465369058;8273.91726082739;8363.205495477927;8485.533295668736;8797.648094076229;8559.74320770378;8640.567971601411;8641.308695304377;8646.870296945552;8647.481151130936;2461.2739241923678;2490.6762120924254;2490.850548967059;2493.264486976337;2494;2384.0940442631863;2485.0432583455317;2486.018022880961;2487.3035550046015;2490.0413340863806;2432.7080750309988;2445.9633105503344;2448.608222684371;2453.374389530667;2457.8033757299463;2399.460121472672;2415.625578035407;2448.4735781806817;2451.485188110481;2452.791512721421;2390.103711108334;2408.590539608271;2416.0094361311776;2430.902763889442;2433.549793288247;8596.742097737078;8749.7812554686;8753.824923501557;8772.078931712205;8775.561221938942;5413.53984911283;5550.47270509301;5579.414161513064;5645.15322701594;5653.519450846683;3340.081477593657;3358.983205083983;3407.47184186449;3415.590129184489;3540.150363912668;1173.8826117388278;1183.887530684592;1202.801537746271;1205.2226314027491;1260.5021016698354;12036.699082522919;12044.27734335934;12113.576024839176;12122.515099396014;12139.575114871026;4419.889502762457;4760.809567617326;4794.640401969797;4821.807127714852;4823.541763532458;9550.761230969281;9583.664571739955;9586.712398628053;9593.28050396223;9593.952030239943;5481.287432633732;5487.533559647474;5492;5492.038893193675;5493.340799104133;4251.87244382669;4417.624501917308;4526.072155208174;5068.56917162038;5147.922781158286;4024.752326778708;4071.1043570414463;4146.37804329347;4167;4180.519240287345;1285.7299967007034;1297.8053292006275;1300.9934950325378;1312.173330801589;1313.0677219174302;884.8982367027875;997.5560875410373;1011.0799172752907;1019.8674172357546;1031.298716872534;6045.304789949124;6062.9090563641585;6067.453929146398;6113.480354169946;6176.197094377792;471.1942578191331;472.0841567359312;484.5856792442411;490.8650121216694;494.91833847415495;3941.3693808990424;4067.633912947849;4094.0788322627172;4132.772697501606;4165.854195103157;10107.494625268708;10777.245592808427;10812.080973117216;10820.72948176286;10829.350238985686;10088.74778130538;10442;10703.625373111903;10713.517891694892;10749.892501075046;8205.58972051395;8384.53885036329;8389.03526094507;8396.832063358699;8405.201505856934;6105.877882442415;6129.84675383119;6247.406496382836;6259.718312676032;6292;9638.759031024281;9841.163501102486;9854;9907.851382229128;9968.40189588627;8953.59708813118;9214.170724634814;9904.50477476109;10008.199344052604;10055.69832905014;7345.926540734525;7589.1272503660575;7589.772306830804;7694.846103078019;7826.334761545332;8573.828523429373;8587.098354672919;8610.526421046903;8623.611937462703;8627.568621568771;7654.961725191339;7715.807104822425;7740.612969351398;7749.225077492206;7783.571903545133;7323.194448610542;7425.888611670721;7513.924860751541;7546.434017448823;7740.032495938008;6676.198856137295;6809.931900681128;6828.897566536407;6832.726690932307;6837.247902730795;5243.737813109253;5271.314729085195;5447.400785913625;5452.836414907559;5614.494695477427;5197.7141257231215;5239.371275446971;5287.101192797157;5296.519230577223;5321.095413779744 02:49:32 INFO - PROCESS | 20850 | |4;prototype.html;350.6020666543474;364.3605472395945;365.5795834789991;368.8672078051901;372.895589235014;5219.0083884062005;5340.919886201706;5361.195820626908;5440.319960004999;5456.154296084108;5133.512316329952;5237.86905327367;5266.683998960065;5278.604104692154;5295.735213239342;4238.4913810342805;4243.557190555211;4247.702660813744;4251.574842515754;4264.808083636229;4132.752034877917;4205.179989901971;4218.894527636803;4227.182311606009;4229.259879521087;4183.874483765492;4185.267578173823;4193.643540299063;4203.180379825935;4214.178235244129;4179.9373009404735;4188.74867507949;4202.642775364067;4214.599613036757;4215.45199124115;3706.813819577736;3794.1842503861803;3804.5054142961517;3806.3148633246005;3828.2343531293855;5180.8963820723375;5189.974050129726;5191.5846732261325;5199.478253047269;5211.557017653466;4871.342368780205;4871.464138944713;4879.243717223836;4909.68087074339;4933.55597996182;5402.648827826179;5514.3658479275;5529.502344788988;5579.525740312079;5603.943960560383;4185.811638476276;4194.664426845845;4195.580441955811;4196.307609244471;4197.4753155855515;5765.942340576583;5812.215350927655;5816.434099232125;5843.328017278025;5847.210626565402;4205.684573656988;4253.319938624226;4280.743155410685;4326.848560300437;4343.370211319341;4357.586029327209;4391.736495810262;4396.274614688605;4397.6806957912495;4407.206702793528;4851.611871050308;4879.804807807719;4900.166971614834;4902.338184345068;4907.454151942126;5522.30971128609;5629.746661400247;5639.125935480007;5649.4012754133555;5663.6035477517;1358.6195865157772;1385.6535866033491;1422.964425889361;1448.8840892728556;1453.229788212249;1009.5608410341525;1036.2953191829477;1042.61944390297;1047.5809676129609;1061.5117046158853;5118.692878427306;5131.3579654510195;5160.284595091528;5177.922331165036;5180.896382072413;5438.939406815712;5446.782128714886;5454.754536045887;5480.479354461319;5498.972505137449;5038.2190760432195;5042.672226305279;5208.427073021964;5213.7914483421;5231.398389185292;2882.3658795065053;2887.888163057196;2890.9159065350495;2892.7107289271325;2898.8550572471713;5526.115821468546;5540.891821635689;5547.44525547442;5554.416786237468;5565.749541270652;5369.19462080691;5529.4470552944385;5574.693391863405;5577.462254674114;5581.190727344593;5500.862478437991;5502.174673798882;5514.738957027599;5560.972195138998;5579.218909352694;5436.972815135899;5439.864003399946;5471.9726401369335;5480.671159730269;5505.366882808528;5674.517665998436;5681.431856814285;5698.772049118154;5703.404950747317;5725.912076705413;5825.000124935576;5836.153757705194;5836.912446313224;5888.0569412094765;5906.497947674324;3977.721559490808;4146.709730318848;4152.2525945328925;4198.685098617555;4216.957830421657;5484.369297530676;5557.5553955682635;5689.317281926195;5690.5163061140265;5704.344000440003;5450.664587176008;5619.679375346872;5638.097904335286;5658.915116273177;5669.659820410789;5633.4366563344975;5644.774209031592;5645.379008309001;5656.43435656431;5664.716764161858;5364.731763411735;5553.250311207935;5594.38461769197;5600.747966341443;5613.719314034201;5672.943270567406;5678.574106942078;5692.1461780733225;5700.486956173964;5703.401142879938;5429.212764149255;5481.451854814646;5550.835174282114;5611.719414029364;5618.185363122406 02:49:32 INFO - PROCESS | 20850 | |5;yui.html;763.0881097088977;773.3117525402391;788.2039140468125;795.7135431244754;906.1527471813855;14501.637459063515;15583.844161558382;15585.610359741013;15657.765133523006;15658.13880236588;14524.564263072125;14683.486077987272;14687.92656036721;14696.412143514246;14712.11727296363;840.3235395506615;867.7093173786789;867.8394497018072;872.1540106097108;872.7992561710811;855.8331125430512;858.6694122762719;859.2266959736224;859.2610355094614;859.5358506406533;900.3517467423477;904.1817155474273;908.3686837647838;908.7682640926555;910.0353625157321;908.6138391183787;909.6997990663132;910.5629297936961;914.2503147419119;916.3448134583771;666.183924692253;667.5961043568619;667.8797816393047;668.4852663449117;669.1769123977535;15148.318325675371;15198.924005380013;15261.084334939827;15282.847171528365;15293.464728734552;13964.371603277878;14604.34280457382;14621.26893655313;14849.777253341208;14861;11803.881961180365;12078.698032549257;12263.877361226363;12379.814302785466;12383.566575169916;3717.3308804415196;3733.701303895682;3743.737938344317;3779.622037796226;3835.3096442640594;44794.55205447936;46187.30719039183;51616.48383516154;54031.45968540343;63613.36386636167;10773.24587278883;11182.496787644575;11203.775924481464;11518.578672159781;12110.576129835414;20443.158773708863;20567;20700;20738.792612073987;21019.579608407745;8209.384296177692;8230.21812927771;8255.174482551696;8325.83348333042;8355.874661880076;4433.135538569948;4484.282514797682;4542.432195975503;4591.931121033187;4592.2422800238255;3580.964190358115;3684;3718.721095917817;3722.8324725387424;3724.404095344786;637.0953246390137;646.3859333633068;653.7907869481816;661.5898143151277;666.6166954001469;744.4528271720282;750.0624219725344;751.6730222353294;757.2124990010327;763.2177018555914;9025.45847249154;9098.499582523025;9456.763580910532;9477.147056764925;9726.756831079138;627.1251604012377;632.0140580694132;712.5772868470932;722.6747963416484;731.2304223778469;4193.643540299109;4360.040791025969;4495.033567782943;4536.115457485825;4590.839320623762;88153;88658.55670721734;88791.55604221938;89281.55359223293;89470.55264723634;48873;75473.6226318865;80666.59666701629;81805;82582.17417825745;74107;74241.62879185677;74635;75581.62209188919;76365.61817190879;8629.8705519416;8841.513716745641;8856.114388561093;8976.910230897607;9207.631694732403;35599;37143.814280928425;40286.597134028285;41888.16223675571;44923;61206.38793612007;61418.77162456815;61921;62956.370436296886;63547.68226159024;12662.176958497668;12682.365881705693;12698.746025079632;12706;13072.738545229233;13331.266780327174;13596;13835.79246311286;14587.489437869624;14805.03767255125;12398.504059837505;12405.44175512086;12581.559645412366;13044.629784171913;13080.345982701017;11881.22772019816;12134.332611706088;12341.876581234432;12471.438785254504;12700.491980320683;12443.875561244633;12636.55772047974;12666.430010649727;12729.236245825281;12846.229226246454;11119.277246979244;11404.429778511207;12020.33888136126;12043.458044387848;12198;11143.83284250753;11354.829677554679;11434.371109589052;11477.426128693365;11534.3079415232 02:49:32 INFO - PROCESS | 20850 | __end_tp_report 02:49:32 INFO - PROCESS | 20850 | __start_cc_report 02:49:32 INFO - PROCESS | 20850 | _x_x_mozilla_cycle_collect,1155 02:49:32 INFO - PROCESS | 20850 | __end_cc_report 02:49:32 INFO - PROCESS | 20850 | __startTimestamp1483354172129__endTimestamp 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | ------- Summary: start ------- 02:49:32 INFO - PROCESS | 20850 | Number of tests: 6 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#0] dojo.html Cycles:165 Average:5590.06 Median:5805.33 stddev:638.90 (11.0%) stddev-sans-first:613.22 02:49:32 INFO - PROCESS | 20850 | Values: 3220.9 3253.4 3268.6 3285.5 3304.1 5468.4 5591.7 5609.6 5612.0 5622.7 5562.0 5627.2 5631.7 5648.3 5666.8 5068.1 5084.2 5108.6 5141.6 5159.1 4976.8 4995.7 5168.3 5183.6 5188.9 5006.1 5011.6 5104.2 5126.9 5148.8 5071.3 5075.6 5146.3 5150.7 5180.4 4829.3 5024.6 5043.6 5083.8 5109.7 5370.7 5442.4 5487.0 5498.5 5514.3 5964.1 6034.9 6049.9 6050.2 6053.3 5883.4 6085.6 6090.3 6102.5 6110.6 5521.8 5590.0 5639.4 5646.4 5660.9 6166.9 6171.4 6174.3 6180.5 6204.5 5747.1 5982.8 5995.2 5999.4 5999.9 5873.4 5918.7 5961.6 5963.2 6065.0 5995.6 6005.0 6005.7 6010.1 6051.6 5964.1 5977.0 5978.9 6005.9 6017.2 4591.2 4613.7 4616.5 4669.3 4676.7 4144.0 4167.4 4181.9 4191.5 4197.2 5636.3 5682.1 5705.9 5713.5 5726.7 5999.9 6052.5 6055.0 6068.6 6091.0 5709.5 5714.3 5715.7 5726.6 5738.9 4991.2 5051.0 5116.7 5129.7 5138.5 6068.9 6153.7 6158.2 6160.2 6163.6 6060.2 6068.7 6072.5 6087.8 6100.7 5986.8 6139.6 6145.5 6150.6 6157.2 5805.3 5858.0 5865.9 5880.1 6011.7 6146.5 6152.2 6155.3 6157.7 6158.5 5951.9 5999.7 6019.8 6025.1 6027.8 5729.8 5780.5 5901.9 5944.3 5946.6 5963.7 5969.5 5975.7 5978.8 5982.4 6025.5 6040.9 6042.9 6043.5 6050.3 5457.6 5699.7 5721.6 5743.1 5887.9 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#1] ext.html Cycles:180 Average:65177.46 Median:43542.85 stddev:130342.98 (299.3%) stddev-sans-first:130618.42 02:49:32 INFO - PROCESS | 20850 | Values: 590.7 622.9 656.1 657.9 658.5 33463.0 43595.3 44455.6 44474.8 44512.8 44800.3 45356.0 45391.0 45447.3 45503.3 8752.0 8897.6 8905.2 8906.2 8911.3 8726.2 8806.1 8812.1 8821.7 8824.1 8796.1 8821.8 8874.5 8875.7 8879.6 8801.7 8832.2 8847.0 8849.7 8855.0 8733.7 8744.6 8759.3 8813.3 8818.9 43030.4 43188.0 43248.6 43481.1 43490.3 3574.3 3604.9 3626.3 3690.5 3809.3 32648.3 32821.0 33059.3 33284.0 33373.7 4433.3 4449.4 4479.1 4501.7 4578.6 514991.0 515680.0 517058.0 519166.0 521912.0 63909.0 64454.4 64566.7 64584.7 64595.4 39076.4 67847.3 68160.3 68188.0 68196.7 17813.2 18413.8 18419.0 18432.6 18539.9 14079.3 14212.4 14225.6 14230.1 14628.9 20214.6 20384.9 20431.0 20470.8 20618.1 7320.9 7386.2 7562.7 7599.0 7662.2 959.2 993.6 1058.8 1122.6 1142.4 30684.7 33245.5 33328.8 33387.8 33558.0 1153.6 1168.2 1169.7 1172.8 1274.3 16243.6 17179.6 17236.2 17513.1 17591.1 533166.0 537252.0 538207.0 538386.0 541093.0 61588.4 61888.4 61966.4 61989.0 62110.4 1328.6 1365.0 1414.2 1463.1 1476.2 31238.5 35309.0 35451.8 35740.8 35777.3 52023.7 52593.5 52690.2 52796.7 52797.5 406040.0 407953.0 408669.0 410674.0 411540.0 29351.6 30450.5 30564.0 30574.7 30617.8 49643.3 49658.3 49857.3 49960.0 51104.2 41094.4 41710.4 42123.6 42271.8 43911.3 40808.2 41837.4 42868.4 43063.8 43216.4 42465.8 43241.4 44066.6 44116.3 44405.3 35354.0 37234.6 37313.4 37836.8 37910.8 29404.9 29544.1 29592.4 29609.6 29732.0 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#2] jquery.html Cycles:180 Average:29379.43 Median:23552.23 stddev:83862.86 (356.1%) stddev-sans-first:84069.88 02:49:32 INFO - PROCESS | 20850 | Values: 397.9 429.7 437.3 441.9 442.9 15807.5 18999.2 19748.6 20699.4 20856.2 19173.7 19849.7 20181.5 20379.0 20521.5 5811.5 6023.5 6030.0 6030.8 6035.0 5577.2 5837.8 5887.7 5893.3 5902.8 5664.4 5851.5 5858.7 5861.6 5864.0 5776.1 5780.8 5804.1 5812.9 5815.3 5210.8 5237.1 5258.0 5276.5 5277.6 23311.3 23360.6 23460.0 23468.4 23636.1 2471.3 2509.6 2572.5 2697.5 2908.2 14947.2 15068.6 15141.3 15251.6 15440.2 1995.1 2007.7 2009.6 2033.3 2053.6 81652.6 83325.0 84369.6 85647.0 85964.0 9995.7 11044.1 11113.6 11235.9 11289.3 14077.3 14741.9 14775.6 14806.7 14841.9 8174.3 8346.3 8365.3 8535.9 8576.7 8069.4 8075.7 8208.9 8233.9 8262.0 6932.4 7002.8 7036.6 7091.6 7120.5 1998.5 2089.9 2108.6 2119.8 2132.8 984.3 1041.9 1045.1 1057.8 1080.6 20185.2 20468.2 20771.6 20808.5 20862.2 1052.6 1075.1 1080.4 1108.5 1120.0 11064.4 11716.6 11805.5 12032.9 12084.5 500931.0 503592.0 504985.0 522407.0 524807.0 51636.5 63990.0 81127.0 82809.6 83668.6 1022.5 1042.2 1050.1 1055.7 1057.1 17683.0 18172.5 18203.2 18641.3 18871.6 40582.8 41193.0 41478.0 42032.0 42148.6 53962.2 54025.5 54371.2 56024.7 56214.4 8589.7 8960.4 9008.0 9065.3 9197.1 13174.0 13188.2 13231.8 13572.5 13721.3 10277.0 10916.4 11019.3 11784.4 11899.3 11395.1 11601.9 11745.8 12008.1 12018.7 11323.5 11619.5 11672.4 11835.5 12105.9 7859.9 8267.1 8306.4 8485.2 9095.0 9241.1 10914.6 11416.8 11466.2 11632.7 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#3] mootools.html Cycles:180 Average:5763.84 Median:5218.54 stddev:3176.26 (60.9%) stddev-sans-first:3168.51 02:49:32 INFO - PROCESS | 20850 | Values: 1435.0 1478.5 1535.0 1715.0 1860.2 7589.7 8273.9 8363.2 8485.5 8797.6 8559.7 8640.6 8641.3 8646.9 8647.5 2461.3 2490.7 2490.9 2493.3 2494.0 2384.1 2485.0 2486.0 2487.3 2490.0 2432.7 2446.0 2448.6 2453.4 2457.8 2399.5 2415.6 2448.5 2451.5 2452.8 2390.1 2408.6 2416.0 2430.9 2433.5 8596.7 8749.8 8753.8 8772.1 8775.6 5413.5 5550.5 5579.4 5645.2 5653.5 3340.1 3359.0 3407.5 3415.6 3540.2 1173.9 1183.9 1202.8 1205.2 1260.5 12036.7 12044.3 12113.6 12122.5 12139.6 4419.9 4760.8 4794.6 4821.8 4823.5 9550.8 9583.7 9586.7 9593.3 9594.0 5481.3 5487.5 5492.0 5492.0 5493.3 4251.9 4417.6 4526.1 5068.6 5147.9 4024.8 4071.1 4146.4 4167.0 4180.5 1285.7 1297.8 1301.0 1312.2 1313.1 884.9 997.6 1011.1 1019.9 1031.3 6045.3 6062.9 6067.5 6113.5 6176.2 471.2 472.1 484.6 490.9 494.9 3941.4 4067.6 4094.1 4132.8 4165.9 10107.5 10777.2 10812.1 10820.7 10829.4 10088.7 10442.0 10703.6 10713.5 10749.9 8205.6 8384.5 8389.0 8396.8 8405.2 6105.9 6129.8 6247.4 6259.7 6292.0 9638.8 9841.2 9854.0 9907.9 9968.4 8953.6 9214.2 9904.5 10008.2 10055.7 7345.9 7589.1 7589.8 7694.8 7826.3 8573.8 8587.1 8610.5 8623.6 8627.6 7655.0 7715.8 7740.6 7749.2 7783.6 7323.2 7425.9 7513.9 7546.4 7740.0 6676.2 6809.9 6828.9 6832.7 6837.2 5243.7 5271.3 5447.4 5452.8 5614.5 5197.7 5239.4 5287.1 5296.5 5321.1 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#4] prototype.html Cycles:180 Average:4692.82 Median:5225.20 stddev:1334.84 (25.5%) stddev-sans-first:1298.19 02:49:32 INFO - PROCESS | 20850 | Values: 350.6 364.4 365.6 368.9 372.9 5219.0 5340.9 5361.2 5440.3 5456.2 5133.5 5237.9 5266.7 5278.6 5295.7 4238.5 4243.6 4247.7 4251.6 4264.8 4132.8 4205.2 4218.9 4227.2 4229.3 4183.9 4185.3 4193.6 4203.2 4214.2 4179.9 4188.7 4202.6 4214.6 4215.5 3706.8 3794.2 3804.5 3806.3 3828.2 5180.9 5190.0 5191.6 5199.5 5211.6 4871.3 4871.5 4879.2 4909.7 4933.6 5402.6 5514.4 5529.5 5579.5 5603.9 4185.8 4194.7 4195.6 4196.3 4197.5 5765.9 5812.2 5816.4 5843.3 5847.2 4205.7 4253.3 4280.7 4326.8 4343.4 4357.6 4391.7 4396.3 4397.7 4407.2 4851.6 4879.8 4900.2 4902.3 4907.5 5522.3 5629.7 5639.1 5649.4 5663.6 1358.6 1385.7 1423.0 1448.9 1453.2 1009.6 1036.3 1042.6 1047.6 1061.5 5118.7 5131.4 5160.3 5177.9 5180.9 5438.9 5446.8 5454.8 5480.5 5499.0 5038.2 5042.7 5208.4 5213.8 5231.4 2882.4 2887.9 2890.9 2892.7 2898.9 5526.1 5540.9 5547.4 5554.4 5565.7 5369.2 5529.4 5574.7 5577.5 5581.2 5500.9 5502.2 5514.7 5561.0 5579.2 5437.0 5439.9 5472.0 5480.7 5505.4 5674.5 5681.4 5698.8 5703.4 5725.9 5825.0 5836.2 5836.9 5888.1 5906.5 3977.7 4146.7 4152.3 4198.7 4217.0 5484.4 5557.6 5689.3 5690.5 5704.3 5450.7 5619.7 5638.1 5658.9 5669.7 5633.4 5644.8 5645.4 5656.4 5664.7 5364.7 5553.3 5594.4 5600.7 5613.7 5672.9 5678.6 5692.1 5700.5 5703.4 5429.2 5481.5 5550.8 5611.7 5618.2 02:49:32 INFO - PROCESS | 20850 | 02:49:32 INFO - PROCESS | 20850 | [#5] yui.html Cycles:180 Average:17603.87 Median:4515.57 stddev:23178.67 (513.3%) stddev-sans-first:23209.20 02:49:32 INFO - PROCESS | 20850 | Values: 763.1 773.3 788.2 795.7 906.2 14501.6 15583.8 15585.6 15657.8 15658.1 14524.6 14683.5 14687.9 14696.4 14712.1 840.3 867.7 867.8 872.2 872.8 855.8 858.7 859.2 859.3 859.5 900.4 904.2 908.4 908.8 910.0 908.6 909.7 910.6 914.3 916.3 666.2 667.6 667.9 668.5 669.2 15148.3 15198.9 15261.1 15282.8 15293.5 13964.4 14604.3 14621.3 14849.8 14861.0 11803.9 12078.7 12263.9 12379.8 12383.6 3717.3 3733.7 3743.7 3779.6 3835.3 44794.6 46187.3 51616.5 54031.5 63613.4 10773.2 11182.5 11203.8 11518.6 12110.6 20443.2 20567.0 20700.0 20738.8 21019.6 8209.4 8230.2 8255.2 8325.8 8355.9 4433.1 4484.3 4542.4 4591.9 4592.2 3581.0 3684.0 3718.7 3722.8 3724.4 637.1 646.4 653.8 661.6 666.6 744.5 750.1 751.7 757.2 763.2 9025.5 9098.5 9456.8 9477.1 9726.8 627.1 632.0 712.6 722.7 731.2 4193.6 4360.0 4495.0 4536.1 4590.8 88153.0 88658.6 88791.6 89281.6 89470.6 48873.0 75473.6 80666.6 81805.0 82582.2 74107.0 74241.6 74635.0 75581.6 76365.6 8629.9 8841.5 8856.1 8976.9 9207.6 35599.0 37143.8 40286.6 41888.2 44923.0 61206.4 61418.8 61921.0 62956.4 63547.7 12662.2 12682.4 12698.7 12706.0 13072.7 13331.3 13596.0 13835.8 14587.5 14805.0 12398.5 12405.4 12581.6 13044.6 13080.3 11881.2 12134.3 12341.9 12471.4 12700.5 12443.9 12636.6 12666.4 12729.2 12846.2 11119.3 11404.4 12020.3 12043.5 12198.0 11143.8 11354.8 11434.4 11477.4 11534.3 02:49:32 INFO - PROCESS | 20850 | -------- Summary: end -------- 02:49:32 INFO - PROCESS | 20850 | 02:49:33 INFO - TEST-INFO | 20850: exit 0 02:49:33 INFO - TEST-OK | dromaeo_css | took 1117391ms 02:49:33 INFO - TEST-START | kraken 02:49:33 INFO - operating with platform_type : linux_ 02:49:33 INFO - Initialising browser for kraken test... 02:49:33 INFO - TEST-INFO | started process 21170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbU_i38/profile http://localhost:39113/getInfo.html) 02:49:37 INFO - PROCESS | 21170 | __metrics Screen width/height:1600/1200 02:49:37 INFO - PROCESS | 21170 | colorDepth:24 02:49:37 INFO - PROCESS | 21170 | Browser inner width/height: 1024/697 02:49:37 INFO - PROCESS | 21170 | __metrics 02:49:38 INFO - PROCESS | 21170 | 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" 02:49:38 INFO - PROCESS | 21170 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:39 INFO - PROCESS | 21170 | console.error: PushService: 02:49:39 INFO - PROCESS | 21170 | stateChangeProcessEnqueue: Error transitioning state 02:49:39 INFO - PROCESS | 21170 | UnknownError 02:49:39 INFO - TEST-INFO | 21170: exit 0 02:49:39 INFO - Browser initialized. 02:49:39 INFO - Running cycle 1/1 for kraken test... 02:49:39 INFO - TEST-INFO | started process 21267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbU_i38/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:51 INFO - PROCESS | 21267 | RSS: Main: 144617472 02:49:51 INFO - PROCESS | 21267 | 02:49:53 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39113/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:54 INFO - PROCESS | 21267 | RSS: Main: 185765888 02:49:54 INFO - PROCESS | 21267 | 02:49:57 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39113/tests/kraken/driver.html?testName=audio-dft) 02:49:57 INFO - PROCESS | 21267 | RSS: Main: 175468544 02:49:57 INFO - PROCESS | 21267 | 02:50:00 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39113/tests/kraken/driver.html?testName=audio-fft) 02:50:01 INFO - PROCESS | 21267 | RSS: Main: 267141120 02:50:01 INFO - PROCESS | 21267 | 02:50:03 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39113/tests/kraken/driver.html?testName=audio-oscillator) 02:50:03 INFO - PROCESS | 21267 | RSS: Main: 173285376 02:50:03 INFO - PROCESS | 21267 | 02:50:05 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39113/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:50:06 INFO - PROCESS | 21267 | RSS: Main: 175685632 02:50:06 INFO - PROCESS | 21267 | 02:50:09 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39113/tests/kraken/driver.html?testName=imaging-darkroom) 02:50:10 INFO - PROCESS | 21267 | RSS: Main: 212107264 02:50:10 INFO - PROCESS | 21267 | 02:50:13 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39113/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:14 INFO - PROCESS | 21267 | RSS: Main: 213106688 02:50:14 INFO - PROCESS | 21267 | 02:50:16 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39113/tests/kraken/driver.html?testName=json-parse-financial) 02:50:17 INFO - PROCESS | 21267 | RSS: Main: 211439616 02:50:17 INFO - PROCESS | 21267 | 02:50:18 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39113/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:19 INFO - PROCESS | 21267 | RSS: Main: 173760512 02:50:19 INFO - PROCESS | 21267 | 02:50:21 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:21 INFO - PROCESS | 21267 | RSS: Main: 180981760 02:50:21 INFO - PROCESS | 21267 | 02:50:23 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:24 INFO - PROCESS | 21267 | RSS: Main: 190251008 02:50:24 INFO - PROCESS | 21267 | 02:50:26 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:27 INFO - PROCESS | 21267 | RSS: Main: 199032832 02:50:27 INFO - PROCESS | 21267 | 02:50:30 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:30 INFO - PROCESS | 21267 | RSS: Main: 195063808 02:50:30 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | Cycle 1(1): loaded http://localhost:39113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39113/tests/kraken/driver.html?testName=ai-astar) 02:50:32 INFO - PROCESS | 21267 | RSS: Main: 247152640 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | __start_tp_report 02:50:32 INFO - PROCESS | 21267 | _x_x_mozilla_page_load 02:50:32 INFO - PROCESS | 21267 | _x_x_mozilla_page_load_details 02:50:32 INFO - PROCESS | 21267 | |i|pagename|runs| 02:50:32 INFO - PROCESS | 21267 | |0;ai-astar;102;111;111;110;110;111;111;110;110;110 02:50:32 INFO - PROCESS | 21267 | |1;audio-beat-detection;146;119;119;156;117;124;122;119;150;117 02:50:32 INFO - PROCESS | 21267 | |2;audio-dft;161;159;160;161;159;161;163;162;161;160 02:50:32 INFO - PROCESS | 21267 | |3;audio-fft;74;77;75;109;76;75;76;76;98;75 02:50:32 INFO - PROCESS | 21267 | |4;audio-oscillator;82;81;109;83;83;82;102;83;81;106 02:50:32 INFO - PROCESS | 21267 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;116;116;117 02:50:32 INFO - PROCESS | 21267 | |6;imaging-darkroom;147;145;145;145;145;146;145;146;146;145 02:50:32 INFO - PROCESS | 21267 | |7;imaging-desaturate;84;85;85;86;85;84;85;86;85;85 02:50:32 INFO - PROCESS | 21267 | |8;json-parse-financial;50;50;50;50;49;50;51;50;51;52 02:50:32 INFO - PROCESS | 21267 | |9;json-stringify-tinderbox;59;74;59;59;61;60;59;60;60;59 02:50:32 INFO - PROCESS | 21267 | |10;stanford-crypto-aes;74;77;80;74;75;75;79;74;74;74 02:50:32 INFO - PROCESS | 21267 | |11;stanford-crypto-ccm;133;124;124;127;132;124;134;122;168;126 02:50:32 INFO - PROCESS | 21267 | |12;stanford-crypto-pbkdf2;154;155;156;153;153;151;152;151;153;161 02:50:32 INFO - PROCESS | 21267 | |13;stanford-crypto-sha256-iterative;69;64;67;64;62;63;72;63;64;62 02:50:32 INFO - PROCESS | 21267 | __end_tp_report 02:50:32 INFO - PROCESS | 21267 | __start_cc_report 02:50:32 INFO - PROCESS | 21267 | _x_x_mozilla_cycle_collect,1632 02:50:32 INFO - PROCESS | 21267 | __end_cc_report 02:50:32 INFO - PROCESS | 21267 | __startTimestamp1483354232603__endTimestamp 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | ------- Summary: start ------- 02:50:32 INFO - PROCESS | 21267 | Number of tests: 14 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.50 stddev:2.72 (2.5%) stddev-sans-first:0.53 02:50:32 INFO - PROCESS | 21267 | Values: 102.0 111.0 111.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:123.00 stddev:15.35 (12.5%) stddev-sans-first:14.98 02:50:32 INFO - PROCESS | 21267 | Values: 146.0 119.0 119.0 156.0 117.0 124.0 122.0 119.0 150.0 117.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 02:50:32 INFO - PROCESS | 21267 | Values: 161.0 159.0 160.0 161.0 159.0 161.0 163.0 162.0 161.0 160.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#3] audio-fft Cycles:10 Average:81.10 Median:76.00 stddev:12.11 (15.9%) stddev-sans-first:12.57 02:50:32 INFO - PROCESS | 21267 | Values: 74.0 77.0 75.0 109.0 76.0 75.0 76.0 76.0 98.0 75.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:11.51 (14.0%) stddev-sans-first:11.91 02:50:32 INFO - PROCESS | 21267 | Values: 82.0 81.0 109.0 83.0 83.0 82.0 102.0 83.0 81.0 106.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:50:32 INFO - PROCESS | 21267 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 116.0 117.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:145.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 02:50:32 INFO - PROCESS | 21267 | Values: 147.0 145.0 145.0 145.0 145.0 146.0 145.0 146.0 146.0 145.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 02:50:32 INFO - PROCESS | 21267 | Values: 84.0 85.0 85.0 86.0 85.0 84.0 85.0 86.0 85.0 85.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 02:50:32 INFO - PROCESS | 21267 | Values: 50.0 50.0 50.0 50.0 49.0 50.0 51.0 50.0 51.0 52.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:60.00 stddev:4.62 (7.7%) stddev-sans-first:4.84 02:50:32 INFO - PROCESS | 21267 | Values: 59.0 74.0 59.0 59.0 61.0 60.0 59.0 60.0 60.0 59.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#10] stanford-crypto-aes Cycles:10 Average:75.60 Median:75.00 stddev:2.27 (3.0%) stddev-sans-first:2.33 02:50:32 INFO - PROCESS | 21267 | Values: 74.0 77.0 80.0 74.0 75.0 75.0 79.0 74.0 74.0 74.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:129.50 stddev:13.54 (10.5%) stddev-sans-first:14.35 02:50:32 INFO - PROCESS | 21267 | Values: 133.0 124.0 124.0 127.0 132.0 124.0 134.0 122.0 168.0 126.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:153.50 stddev:2.96 (1.9%) stddev-sans-first:3.14 02:50:32 INFO - PROCESS | 21267 | Values: 154.0 155.0 156.0 153.0 153.0 151.0 152.0 151.0 153.0 161.0 02:50:32 INFO - PROCESS | 21267 | 02:50:32 INFO - PROCESS | 21267 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:64.00 stddev:3.30 (5.2%) stddev-sans-first:3.17 02:50:32 INFO - PROCESS | 21267 | Values: 69.0 64.0 67.0 64.0 62.0 63.0 72.0 63.0 64.0 62.0 02:50:32 INFO - PROCESS | 21267 | -------- Summary: end -------- 02:50:32 INFO - PROCESS | 21267 | 02:50:33 INFO - TEST-INFO | 21267: exit 0 02:50:33 INFO - TEST-OK | kraken | took 60649ms 02:50:33 INFO - SUITE-END | took 1178s 02:50:33 INFO - Completed test suite (00:19:38) 02:50:33 INFO - javascript benchmark 02:50:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3220.855061522231, 3253.4469140246165, 3268.6077670679524, 3285.490748933916, 3304.09137487191, 5468.371137319209, 5591.692456914868, 5609.607327487078, 5612.0, 5622.690752008638, 5561.972190139054, 5627.155926611, 5631.746571404286, 5648.293963254593, 5666.801661941822, 5068.1384164692, 5084.161113416282, 5108.5913126949945, 5141.640085194038, 5159.122949098643, 4976.751162441881, 4995.650304478688, 5168.302279192318, 5183.559397451221, 5188.948110518903, 5006.098902197603, 5011.599072074244, 5104.2088476286235, 5126.948730512684, 5148.819791307305, 5071.2900193973055, 5075.6447048706605, 5146.330976972969, 5150.742462876841, 5180.352455943007, 4829.251466022772, 5024.598032157455, 5043.621728370387, 5083.79664813407, 5109.718965456898, 5370.7046112463795, 5442.374126975369, 5487.039768040577, 5498.477644623795, 5514.283143191399, 5964.075568286922, 6034.879302413971, 6049.909251361233, 6050.152978583002, 6053.273607167168, 5883.411658834125, 6085.574009819315, 6090.26916769986, 6102.450779429828, 6110.633361998294, 5521.806736764234, 5590.049691552405, 5639.407862174413, 5646.435356464321, 5660.886782264414, 6166.938330616636, 6171.382861713792, 6174.25908890936, 6180.505559555225, 6204.472619827366, 5747.109198074305, 5982.820515384546, 5995.190649262294, 5999.370066143079, 5999.880002399927, 5873.3832947539895, 5918.674472904032, 5961.552883533753, 5963.194968679173, 6065.0, 5995.61028533144, 6004.969975150184, 6005.669688167105, 6010.128531362928, 6051.576389652682, 5964.135200395918, 5976.970115149396, 5978.850528736816, 6005.879882402415, 6017.247844019497, 4591.242444996538, 4613.677042606985, 4616.515265897099, 4669.299605059268, 4676.672632915664, 4143.97928010358, 4167.374893765959, 4181.874543763692, 4191.517975432865, 4197.181549597799, 5636.323641163087, 5682.119271512922, 5705.942940570624, 5713.514351280104, 5726.742296596663, 5999.850003749942, 6052.485538729257, 6054.969725151346, 6068.605540639845, 6091.0, 5709.543236541067, 5714.314282286152, 5715.657060576379, 5726.599138060295, 5738.885222295531, 4991.226359914219, 5051.040302342543, 5116.744162791845, 5129.666571672829, 5138.4604616514725, 6068.908966365508, 6153.7230824613, 6158.168647232746, 6160.229971253593, 6163.630182189083, 6060.212172417558, 6068.696565171812, 6072.453479186895, 6087.786927457518, 6100.725467353891, 5986.790462333797, 6139.631622102688, 6145.539084568586, 6150.600210986271, 6157.199564056823, 5805.332386775575, 5857.970710146422, 5865.912011319919, 5880.117982302518, 6011.699415029144, 6146.508279337553, 6152.200213972334, 6155.2921414037955, 6157.72290246931, 6158.507319414526, 5951.940480595312, 5999.70001499932, 6019.849503762441, 6025.096235564701, 6027.849303767441, 5729.799457018984, 5780.450857168562, 5901.91147132802, 5944.256967879015, 5946.613470124428, 5963.671998040149, 5969.462748352669, 5975.701214939322, 5978.7608495661425, 5982.4316689914385, 6025.548083893638, 6040.909386359296, 6042.8791424170395, 6043.516518678583, 6050.30421501533, 5457.645253058538, 5699.658020518782, 5721.57088218377, 5743.052396354555, 5887.911681324869], "value": 5547.029185571075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7016956436998, 622.8909940760367, 656.1470088884452, 657.9210494740632, 658.4798009572437, 33463.0, 43595.34606980894, 44455.55544444555, 44474.77762611186, 44512.777436112854, 44800.32799508002, 45356.0, 45391.0, 45447.318290225674, 45503.31745023819, 8751.993520745116, 8897.644094236222, 8905.198532132106, 8906.242969347613, 8911.331650126234, 8726.171013753683, 8806.119388061175, 8812.074732153127, 8821.691240806573, 8824.117588241157, 8796.120387961217, 8821.779455513632, 8874.467531948103, 8875.68935087272, 8879.556022198896, 8801.735947921541, 8832.205101540892, 8846.955765221164, 8849.734507964738, 8855.0, 8733.650653973833, 8744.562771861381, 8759.34304927133, 8813.338999575057, 8818.86771698425, 43030.35454468154, 43188.0, 43248.56751432477, 43481.13037739259, 43490.34764478535, 3574.267275208576, 3604.891853244407, 3626.2928728897878, 3690.538682664667, 3809.3333666608232, 32648.347033059206, 32821.01536953895, 33059.33881322384, 33284.0, 33373.6662633373, 4433.334999750031, 4449.399331090293, 4479.081788233437, 4501.729896206238, 4578.633709303248, 514991.0, 515680.0, 517058.0, 519166.0, 521912.0, 63909.0, 64454.355456444835, 64566.677166614805, 64584.677076614316, 64595.35404645988, 39076.41385379222, 67847.32152678509, 68160.31839681539, 68188.0, 68196.6590167046, 17813.19840607176, 18413.81586184121, 18419.0, 18432.63134737298, 18539.90730046368, 14079.296035198198, 14212.43150273998, 14225.573232803032, 14230.14619122856, 14628.853711462962, 20214.58497905162, 20384.89807550953, 20431.0, 20470.795292047187, 20618.072186751633, 7320.926790732131, 7386.224446433154, 7562.697492100255, 7599.048494782793, 7662.195469475736, 959.2182371367313, 993.64228877604, 1058.8147074262126, 1122.5790328626765, 1142.354569668135, 30684.693153068183, 33245.50131748026, 33328.83335583306, 33387.83306083454, 33558.0, 1153.6250718516517, 1168.2348062019391, 1169.7368092179192, 1172.8475298211179, 1274.2800317820402, 16243.593910152103, 17179.570510737332, 17236.224369903386, 17513.12434378276, 17591.120443978005, 533166.0, 537252.0, 538207.0, 538386.0, 541093.0, 61588.38411615916, 61888.381116189164, 61966.38033619606, 61989.0, 62110.37889621136, 1328.5881376773232, 1364.9931750341184, 1414.165642271065, 1463.0636392708675, 1476.2471139718607, 31238.531422029144, 35309.0, 35451.83466828624, 35740.82129589335, 35777.28445431025, 52023.739881301866, 52593.47406526039, 52690.20964685609, 52796.73601631967, 52797.472025279254, 406040.0, 407953.0, 408669.0, 410674.0, 411540.0, 29351.55972660369, 30450.543241851832, 30564.0, 30574.694253057183, 30617.846910765304, 49643.25535116904, 49658.255126172415, 49857.25214121864, 49960.0, 51104.233436497736, 41094.38358424566, 41710.374344384254, 42123.57876421197, 42271.78864105783, 43911.34132988071, 40808.18383632251, 41837.372439414044, 42868.35697464478, 43063.784681076395, 43216.35175472433, 42465.787671061444, 43241.35137972996, 44066.55933440624, 44116.33825492684, 44405.33391999187, 35354.0, 37234.62765372312, 37313.44029839609, 37836.81081594574, 37910.810445947594, 29404.852975734986, 29544.113676589735, 29592.40815183641, 29609.555856661736, 29732.0], "value": 21019.630494003257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.9363301871701, 429.6605681511606, 437.3090516983167, 441.94917584477787, 442.9313456414255, 15807.525774226777, 18999.240030398785, 19748.605027899433, 20699.379018629428, 20856.165753369845, 19173.712394314098, 19849.70225446616, 20181.495462613442, 20379.0, 20521.486962825937, 5811.535077193825, 6023.488003519706, 6029.969850150743, 6030.819075427722, 6035.0, 5577.191307260445, 5837.824865254049, 5887.735051922674, 5893.292804863422, 5902.822915312548, 5664.433556644344, 5851.473367396933, 5858.677772722499, 5861.589688721791, 5863.970680146594, 5776.075827867542, 5780.826575202751, 5804.1293805929445, 5812.88374232513, 5815.331236907747, 5210.817621383233, 5237.109691352479, 5258.000979813862, 5276.498732620395, 5277.577793776527, 23311.300660980196, 23360.64959025616, 23460.0, 23468.413289667726, 23636.054557817668, 2471.270975062361, 2509.623556466526, 2572.498362819251, 2697.5144473994674, 2908.1566345759707, 14947.177905215209, 15068.623284417868, 15141.318640661197, 15251.61870953224, 15440.150791706452, 1995.0623207092642, 2007.708882212071, 2009.5578972626, 2033.2680235115347, 2053.5995480881234, 81652.59173704153, 83325.0, 84369.57815210946, 85647.0, 85964.0, 9995.70012899614, 11044.116470682326, 11113.55501789605, 11235.943820280847, 11289.322640641587, 14077.296135193199, 14741.852581474262, 14775.556733297803, 14806.703865922622, 14841.851581484047, 8174.305184059422, 8346.290565301895, 8365.330773538102, 8535.871961920577, 8576.699815506427, 8069.435139540175, 8075.676972921017, 8208.917910820815, 8233.876491852627, 8262.0, 6932.445404367639, 7002.75490357835, 7036.577805331696, 7091.60996145217, 7120.465965052642, 1998.4803950972853, 2089.853710240269, 2108.599366120432, 2119.809217170462, 2132.829373650104, 984.2716389871587, 1041.9166466682648, 1045.0536447613058, 1057.7632444719184, 1080.6226302135333, 20185.192592296145, 20468.18127274922, 20771.58456830855, 20808.47978800542, 20862.165513379598, 1052.594751020847, 1075.113320733832, 1080.448971024783, 1108.4956344863067, 1120.0, 11064.391458469861, 11716.589919352782, 11805.468753906094, 12032.87967120335, 12084.456199471046, 500931.0, 503592.0, 504985.0, 522407.0, 524807.0, 51636.48363516392, 63990.0, 81127.0, 82809.58595206986, 83668.58165709133, 1022.5347466902541, 1042.2131290875493, 1050.1074087025968, 1055.7466208110152, 1057.1225882517492, 17683.0, 18172.545686357946, 18203.180856861738, 18641.254349825856, 18871.622567548846, 40582.79708601556, 41193.0, 41478.0, 42032.0, 42148.57851421569, 53962.19056714231, 54025.45974540204, 54371.18443223276, 56024.719876400355, 56214.43785562092, 8589.742307730778, 8960.417572858005, 9008.0, 9065.27477801761, 9197.08029197075, 13174.0, 13188.208707477583, 13231.80152297697, 13572.457101716216, 13721.313934303045, 10277.0, 10916.399598022184, 11019.338839669324, 11784.41077946082, 11899.286042837457, 11395.088392928712, 11601.883981160418, 11745.823812642988, 12008.099392545419, 12018.699532511408, 11323.547058117912, 11619.535218591162, 11672.358020308964, 11835.526578936746, 12105.878941210474, 7859.882101768364, 8267.090620031671, 8306.418550701394, 8485.236328730443, 9094.999550049622, 9241.075892410705, 10914.617988370368, 11416.82874756896, 11466.197366184288, 11632.651020469399], "value": 9561.715669461388, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1435.0, 1478.47514132483, 1535.02525896056, 1714.9914250428747, 1860.162926682992, 7589.658465369058, 8273.91726082739, 8363.205495477927, 8485.533295668736, 8797.648094076229, 8559.74320770378, 8640.567971601411, 8641.308695304377, 8646.870296945552, 8647.481151130936, 2461.2739241923678, 2490.6762120924254, 2490.850548967059, 2493.264486976337, 2494.0, 2384.0940442631863, 2485.0432583455317, 2486.018022880961, 2487.3035550046015, 2490.0413340863806, 2432.7080750309988, 2445.9633105503344, 2448.608222684371, 2453.374389530667, 2457.8033757299463, 2399.460121472672, 2415.625578035407, 2448.4735781806817, 2451.485188110481, 2452.791512721421, 2390.103711108334, 2408.590539608271, 2416.0094361311776, 2430.902763889442, 2433.549793288247, 8596.742097737078, 8749.7812554686, 8753.824923501557, 8772.078931712205, 8775.561221938942, 5413.53984911283, 5550.47270509301, 5579.414161513064, 5645.15322701594, 5653.519450846683, 3340.081477593657, 3358.983205083983, 3407.47184186449, 3415.590129184489, 3540.150363912668, 1173.8826117388278, 1183.887530684592, 1202.801537746271, 1205.2226314027491, 1260.5021016698354, 12036.699082522919, 12044.27734335934, 12113.576024839176, 12122.515099396014, 12139.575114871026, 4419.889502762457, 4760.809567617326, 4794.640401969797, 4821.807127714852, 4823.541763532458, 9550.761230969281, 9583.664571739955, 9586.712398628053, 9593.28050396223, 9593.952030239943, 5481.287432633732, 5487.533559647474, 5492.0, 5492.038893193675, 5493.340799104133, 4251.87244382669, 4417.624501917308, 4526.072155208174, 5068.56917162038, 5147.922781158286, 4024.752326778708, 4071.1043570414463, 4146.37804329347, 4167.0, 4180.519240287345, 1285.7299967007034, 1297.8053292006275, 1300.9934950325378, 1312.173330801589, 1313.0677219174302, 884.8982367027875, 997.5560875410373, 1011.0799172752907, 1019.8674172357546, 1031.298716872534, 6045.304789949124, 6062.9090563641585, 6067.453929146398, 6113.480354169946, 6176.197094377792, 471.1942578191331, 472.0841567359312, 484.5856792442411, 490.8650121216694, 494.91833847415495, 3941.3693808990424, 4067.633912947849, 4094.0788322627172, 4132.772697501606, 4165.854195103157, 10107.494625268708, 10777.245592808427, 10812.080973117216, 10820.72948176286, 10829.350238985686, 10088.74778130538, 10442.0, 10703.625373111903, 10713.517891694892, 10749.892501075046, 8205.58972051395, 8384.53885036329, 8389.03526094507, 8396.832063358699, 8405.201505856934, 6105.877882442415, 6129.84675383119, 6247.406496382836, 6259.718312676032, 6292.0, 9638.759031024281, 9841.163501102486, 9854.0, 9907.851382229128, 9968.40189588627, 8953.59708813118, 9214.170724634814, 9904.50477476109, 10008.199344052604, 10055.69832905014, 7345.926540734525, 7589.1272503660575, 7589.772306830804, 7694.846103078019, 7826.334761545332, 8573.828523429373, 8587.098354672919, 8610.526421046903, 8623.611937462703, 8627.568621568771, 7654.961725191339, 7715.807104822425, 7740.612969351398, 7749.225077492206, 7783.571903545133, 7323.194448610542, 7425.888611670721, 7513.924860751541, 7546.434017448823, 7740.032495938008, 6676.198856137295, 6809.931900681128, 6828.897566536407, 6832.726690932307, 6837.247902730795, 5243.737813109253, 5271.314729085195, 5447.400785913625, 5452.836414907559, 5614.494695477427, 5197.7141257231215, 5239.371275446971, 5287.101192797157, 5296.519230577223, 5321.095413779744], "value": 4603.012865798416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.6020666543474, 364.3605472395945, 365.5795834789991, 368.8672078051901, 372.895589235014, 5219.0083884062005, 5340.919886201706, 5361.195820626908, 5440.319960004999, 5456.154296084108, 5133.512316329952, 5237.86905327367, 5266.683998960065, 5278.604104692154, 5295.735213239342, 4238.4913810342805, 4243.557190555211, 4247.702660813744, 4251.574842515754, 4264.808083636229, 4132.752034877917, 4205.179989901971, 4218.894527636803, 4227.182311606009, 4229.259879521087, 4183.874483765492, 4185.267578173823, 4193.643540299063, 4203.180379825935, 4214.178235244129, 4179.9373009404735, 4188.74867507949, 4202.642775364067, 4214.599613036757, 4215.45199124115, 3706.813819577736, 3794.1842503861803, 3804.5054142961517, 3806.3148633246005, 3828.2343531293855, 5180.8963820723375, 5189.974050129726, 5191.5846732261325, 5199.478253047269, 5211.557017653466, 4871.342368780205, 4871.464138944713, 4879.243717223836, 4909.68087074339, 4933.55597996182, 5402.648827826179, 5514.3658479275, 5529.502344788988, 5579.525740312079, 5603.943960560383, 4185.811638476276, 4194.664426845845, 4195.580441955811, 4196.307609244471, 4197.4753155855515, 5765.942340576583, 5812.215350927655, 5816.434099232125, 5843.328017278025, 5847.210626565402, 4205.684573656988, 4253.319938624226, 4280.743155410685, 4326.848560300437, 4343.370211319341, 4357.586029327209, 4391.736495810262, 4396.274614688605, 4397.6806957912495, 4407.206702793528, 4851.611871050308, 4879.804807807719, 4900.166971614834, 4902.338184345068, 4907.454151942126, 5522.30971128609, 5629.746661400247, 5639.125935480007, 5649.4012754133555, 5663.6035477517, 1358.6195865157772, 1385.6535866033491, 1422.964425889361, 1448.8840892728556, 1453.229788212249, 1009.5608410341525, 1036.2953191829477, 1042.61944390297, 1047.5809676129609, 1061.5117046158853, 5118.692878427306, 5131.3579654510195, 5160.284595091528, 5177.922331165036, 5180.896382072413, 5438.939406815712, 5446.782128714886, 5454.754536045887, 5480.479354461319, 5498.972505137449, 5038.2190760432195, 5042.672226305279, 5208.427073021964, 5213.7914483421, 5231.398389185292, 2882.3658795065053, 2887.888163057196, 2890.9159065350495, 2892.7107289271325, 2898.8550572471713, 5526.115821468546, 5540.891821635689, 5547.44525547442, 5554.416786237468, 5565.749541270652, 5369.19462080691, 5529.4470552944385, 5574.693391863405, 5577.462254674114, 5581.190727344593, 5500.862478437991, 5502.174673798882, 5514.738957027599, 5560.972195138998, 5579.218909352694, 5436.972815135899, 5439.864003399946, 5471.9726401369335, 5480.671159730269, 5505.366882808528, 5674.517665998436, 5681.431856814285, 5698.772049118154, 5703.404950747317, 5725.912076705413, 5825.000124935576, 5836.153757705194, 5836.912446313224, 5888.0569412094765, 5906.497947674324, 3977.721559490808, 4146.709730318848, 4152.2525945328925, 4198.685098617555, 4216.957830421657, 5484.369297530676, 5557.5553955682635, 5689.317281926195, 5690.5163061140265, 5704.344000440003, 5450.664587176008, 5619.679375346872, 5638.097904335286, 5658.915116273177, 5669.659820410789, 5633.4366563344975, 5644.774209031592, 5645.379008309001, 5656.43435656431, 5664.716764161858, 5364.731763411735, 5553.250311207935, 5594.38461769197, 5600.747966341443, 5613.719314034201, 5672.943270567406, 5678.574106942078, 5692.1461780733225, 5700.486956173964, 5703.401142879938, 5429.212764149255, 5481.451854814646, 5550.835174282114, 5611.719414029364, 5618.185363122406], "value": 4278.402189638152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.0881097088977, 773.3117525402391, 788.2039140468125, 795.7135431244754, 906.1527471813855, 14501.637459063515, 15583.844161558382, 15585.610359741013, 15657.765133523006, 15658.13880236588, 14524.564263072125, 14683.486077987272, 14687.92656036721, 14696.412143514246, 14712.11727296363, 840.3235395506615, 867.7093173786789, 867.8394497018072, 872.1540106097108, 872.7992561710811, 855.8331125430512, 858.6694122762719, 859.2266959736224, 859.2610355094614, 859.5358506406533, 900.3517467423477, 904.1817155474273, 908.3686837647838, 908.7682640926555, 910.0353625157321, 908.6138391183787, 909.6997990663132, 910.5629297936961, 914.2503147419119, 916.3448134583771, 666.183924692253, 667.5961043568619, 667.8797816393047, 668.4852663449117, 669.1769123977535, 15148.318325675371, 15198.924005380013, 15261.084334939827, 15282.847171528365, 15293.464728734552, 13964.371603277878, 14604.34280457382, 14621.26893655313, 14849.777253341208, 14861.0, 11803.881961180365, 12078.698032549257, 12263.877361226363, 12379.814302785466, 12383.566575169916, 3717.3308804415196, 3733.701303895682, 3743.737938344317, 3779.622037796226, 3835.3096442640594, 44794.55205447936, 46187.30719039183, 51616.48383516154, 54031.45968540343, 63613.36386636167, 10773.24587278883, 11182.496787644575, 11203.775924481464, 11518.578672159781, 12110.576129835414, 20443.158773708863, 20567.0, 20700.0, 20738.792612073987, 21019.579608407745, 8209.384296177692, 8230.21812927771, 8255.174482551696, 8325.83348333042, 8355.874661880076, 4433.135538569948, 4484.282514797682, 4542.432195975503, 4591.931121033187, 4592.2422800238255, 3580.964190358115, 3684.0, 3718.721095917817, 3722.8324725387424, 3724.404095344786, 637.0953246390137, 646.3859333633068, 653.7907869481816, 661.5898143151277, 666.6166954001469, 744.4528271720282, 750.0624219725344, 751.6730222353294, 757.2124990010327, 763.2177018555914, 9025.45847249154, 9098.499582523025, 9456.763580910532, 9477.147056764925, 9726.756831079138, 627.1251604012377, 632.0140580694132, 712.5772868470932, 722.6747963416484, 731.2304223778469, 4193.643540299109, 4360.040791025969, 4495.033567782943, 4536.115457485825, 4590.839320623762, 88153.0, 88658.55670721734, 88791.55604221938, 89281.55359223293, 89470.55264723634, 48873.0, 75473.6226318865, 80666.59666701629, 81805.0, 82582.17417825745, 74107.0, 74241.62879185677, 74635.0, 75581.62209188919, 76365.61817190879, 8629.8705519416, 8841.513716745641, 8856.114388561093, 8976.910230897607, 9207.631694732403, 35599.0, 37143.814280928425, 40286.597134028285, 41888.16223675571, 44923.0, 61206.38793612007, 61418.77162456815, 61921.0, 62956.370436296886, 63547.68226159024, 12662.176958497668, 12682.365881705693, 12698.746025079632, 12706.0, 13072.738545229233, 13331.266780327174, 13596.0, 13835.79246311286, 14587.489437869624, 14805.03767255125, 12398.504059837505, 12405.44175512086, 12581.559645412366, 13044.629784171913, 13080.345982701017, 11881.22772019816, 12134.332611706088, 12341.876581234432, 12471.438785254504, 12700.491980320683, 12443.875561244633, 12636.55772047974, 12666.430010649727, 12729.236245825281, 12846.229226246454, 11119.277246979244, 11404.429778511207, 12020.33888136126, 12043.458044387848, 12198.0, 11143.83284250753, 11354.829677554679, 11434.371109589052, 11477.426128693365, 11534.3079415232], "value": 7249.463046367575, "unit": "score"}], "name": "dromaeo_css", "value": 7361.780426772169, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 119.0, 156.0, 117.0, 124.0, 122.0, 119.0, 150.0, 117.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 161.0, 159.0, 161.0, 163.0, 162.0, 161.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 109.0, 76.0, 75.0, 76.0, 76.0, 98.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 83.0, 83.0, 82.0, 102.0, 83.0, 81.0, 106.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 85.0, 84.0, 85.0, 86.0, 85.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 49.0, 50.0, 51.0, 50.0, 51.0, 52.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 74.0, 59.0, 59.0, 61.0, 60.0, 59.0, 60.0, 60.0, 59.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 80.0, 74.0, 75.0, 75.0, 79.0, 74.0, 74.0, 74.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 124.0, 124.0, 127.0, 132.0, 124.0, 134.0, 122.0, 168.0, 126.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 155.0, 156.0, 153.0, 153.0, 151.0, 152.0, 151.0, 153.0, 161.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 64.0, 67.0, 64.0, 62.0, 63.0, 72.0, 63.0, 64.0, 62.0], "value": 65.0, "unit": "score"}], "name": "kraken", "value": 1453.8000000000002, "alertThreshold": 2.0}]} 02:50:33 INFO - Return code: 0 02:50:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:50:33 INFO - # TBPL SUCCESS # 02:50:33 INFO - Running post-action listener: _resource_record_post_action 02:50:33 INFO - [mozharness: 2017-01-02 10:50:33.902815Z] Finished run-tests step (success) 02:50:33 INFO - Running post-run listener: _resource_record_post_run 02:50:33 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 351866880; Read time: 4; Write time: 576368 02:50:33 INFO - TinderboxPrint: CPU usage
13.0% 02:50:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 02:50:33 INFO - TinderboxPrint: I/O write bytes / time
351,866,880 / 576,368 02:50:33 INFO - TinderboxPrint: CPU idle
8,289.9 (87.0%) 02:50:33 INFO - TinderboxPrint: CPU user
1,190.9 (12.5%) 02:50:33 INFO - TinderboxPrint: Swap in / out
0 / 0 02:50:33 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 107692032; Read time: 0; Write time: 291124 02:50:33 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 243220480; Read time: 0; Write time: 285240 02:50:34 INFO - Running post-run listener: _upload_blobber_files 02:50:34 INFO - Blob upload gear active. 02:50:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:50:34 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 02:50:34 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'] 02:50:34 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 02:50:34 INFO - (blobuploader) - INFO - Open directory for files ... 02:50:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:50:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:50:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:35 INFO - (blobuploader) - INFO - Done attempting. 02:50:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:50:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:50:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:39 INFO - (blobuploader) - INFO - Done attempting. 02:50:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:50:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:50:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:50:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:50:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:50:40 INFO - (blobuploader) - INFO - Done attempting. 02:50:40 INFO - (blobuploader) - INFO - Iteration through files over. 02:50:40 INFO - Return code: 0 02:50:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:50:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:50:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed7b1c9aab163c1eea9d5b6a53fffacbaee1d6134db7c9d53881a06ad1c950f684ef8171156237bcdb0fd61a547108faf5598ed217e5315dff2e708ea2eec0e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2eb7d6474076afdbcb53e0fa53c15bae738cff1a2da64b4c00d58ebe25950afa04f0bce8bb3607b06c57d24a955e225c1e4b8ab1596b3fa8e5f77d34e1fcd76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f223bb7dfb5f603a45ae65c235c0ef6ba78b9d53a82b16c65453f05b3395a7483683eca5867f92fbae97bf0d0d9bc107b93e7cfe76e1d80777530fc94b82bcb8"} 02:50:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:50:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:50:40 INFO - Contents: 02:50:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ed7b1c9aab163c1eea9d5b6a53fffacbaee1d6134db7c9d53881a06ad1c950f684ef8171156237bcdb0fd61a547108faf5598ed217e5315dff2e708ea2eec0e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2eb7d6474076afdbcb53e0fa53c15bae738cff1a2da64b4c00d58ebe25950afa04f0bce8bb3607b06c57d24a955e225c1e4b8ab1596b3fa8e5f77d34e1fcd76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f223bb7dfb5f603a45ae65c235c0ef6ba78b9d53a82b16c65453f05b3395a7483683eca5867f92fbae97bf0d0d9bc107b93e7cfe76e1d80777530fc94b82bcb8"} 02:50:40 INFO - Running post-run listener: copy_logs_to_upload_dir 02:50:40 INFO - Copying logs to upload dir... 02:50:40 INFO - mkdir: /builds/slave/test/build/upload/logs 02:50:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.446381 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-01-02 02:50:38.029787) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 02:50:38.032984) ========= 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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 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/ed7b1c9aab163c1eea9d5b6a53fffacbaee1d6134db7c9d53881a06ad1c950f684ef8171156237bcdb0fd61a547108faf5598ed217e5315dff2e708ea2eec0e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2eb7d6474076afdbcb53e0fa53c15bae738cff1a2da64b4c00d58ebe25950afa04f0bce8bb3607b06c57d24a955e225c1e4b8ab1596b3fa8e5f77d34e1fcd76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f223bb7dfb5f603a45ae65c235c0ef6ba78b9d53a82b16c65453f05b3395a7483683eca5867f92fbae97bf0d0d9bc107b93e7cfe76e1d80777530fc94b82bcb8"} build_url:https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011804 build_url: 'https://queue.taskcluster.net/v1/task/EqKRWNWKRcimvsBl31VX-Q/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/ed7b1c9aab163c1eea9d5b6a53fffacbaee1d6134db7c9d53881a06ad1c950f684ef8171156237bcdb0fd61a547108faf5598ed217e5315dff2e708ea2eec0e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2eb7d6474076afdbcb53e0fa53c15bae738cff1a2da64b4c00d58ebe25950afa04f0bce8bb3607b06c57d24a955e225c1e4b8ab1596b3fa8e5f77d34e1fcd76", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f223bb7dfb5f603a45ae65c235c0ef6ba78b9d53a82b16c65453f05b3395a7483683eca5867f92fbae97bf0d0d9bc107b93e7cfe76e1d80777530fc94b82bcb8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 02:50:38.059808) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:50:38.060201) ========= 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=8783db0840cc980e80bb0bd400000236-1483342633.568737-1237659345 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 02:50:38.146102) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 02:50:38.146555) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 02:50:38.146984) ========= ========= Total master_lag: 0.20 =========