builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1476210023.72 results: success (0) buildid: 20161011094846 builduid: 1afea881fd6a40f19b2b70fb36f27acb revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.719056) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.719607) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.719979) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.734940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.735280) ========= 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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 11:20:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-10-11 11:20:23 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.829893) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.830200) ========= 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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019645 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.879564) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:23.879931) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 11:20:23,989 truncating revision to first 12 chars 2016-10-11 11:20:23,989 Setting DEBUG logging. 2016-10-11 11:20:23,989 attempt 1/10 2016-10-11 11:20:23,990 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/687572ea20cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 11:20:24,407 unpacking tar archive at: fx-team-687572ea20cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.736501 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:24.629607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:24.630092) ========= script_repo_revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:24.630671) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:24.631054) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 11:20:24.642154) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-11 11:20:24.642569) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:20:24 INFO - MultiFileLogger online at 20161011 11:20:24 in /builds/slave/test 11:20:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:20:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:20:24 INFO - {'append_to_log': False, 11:20:24 INFO - 'base_work_dir': '/builds/slave/test', 11:20:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:20:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:20:24 INFO - 'branch': 'Fx-Team-Non-PGO', 11:20:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:20:24 INFO - 'config_files': ('talos/linux_config.py',), 11:20:24 INFO - 'default_actions': ('clobber', 11:20:24 INFO - 'read-buildbot-config', 11:20:24 INFO - 'download-and-extract', 11:20:24 INFO - 'populate-webroot', 11:20:24 INFO - 'create-virtualenv', 11:20:24 INFO - 'install', 11:20:24 INFO - 'run-tests'), 11:20:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:20:24 INFO - 'download_minidump_stackwalk': True, 11:20:24 INFO - 'download_symbols': 'ondemand', 11:20:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:20:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:20:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:20:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:20:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:20:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:20:24 INFO - 'installer_path': 'installer.exe', 11:20:24 INFO - 'log_level': 'info', 11:20:24 INFO - 'log_name': 'talos', 11:20:24 INFO - 'log_to_console': True, 11:20:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:20:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:20:24 INFO - 'opt_config_files': (), 11:20:24 INFO - 'pip_index': False, 11:20:24 INFO - 'sps_profile': False, 11:20:24 INFO - 'sps_profile_interval': 0, 11:20:24 INFO - 'suite': 'dromaeojs', 11:20:24 INFO - 'system_bits': '32', 11:20:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:20:24 INFO - 'title': 'talos-linux64-ix-017', 11:20:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:20:24 INFO - 'use_talos_json': True, 11:20:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:20:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:20:24 INFO - 'work_dir': 'build'} 11:20:24 INFO - [mozharness: 2016-10-11 18:20:24.847893Z] Running clobber step. 11:20:24 INFO - Running pre-action listener: _resource_record_pre_action 11:20:24 INFO - Running main action method: clobber 11:20:24 INFO - rmtree: /builds/slave/test/build 11:20:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:20:25 INFO - Running post-action listener: _resource_record_post_action 11:20:25 INFO - [mozharness: 2016-10-11 18:20:25.328552Z] Finished clobber step (success) 11:20:25 INFO - [mozharness: 2016-10-11 18:20:25.328652Z] Running read-buildbot-config step. 11:20:25 INFO - Running pre-action listener: _resource_record_pre_action 11:20:25 INFO - Running main action method: read_buildbot_config 11:20:25 INFO - Using buildbot properties: 11:20:25 INFO - { 11:20:25 INFO - "project": "", 11:20:25 INFO - "product": "firefox", 11:20:25 INFO - "script_repo_revision": "production", 11:20:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:20:25 INFO - "repository": "", 11:20:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:20:25 INFO - "buildid": "20161011094846", 11:20:25 INFO - "pgo_build": "False", 11:20:25 INFO - "basedir": "/builds/slave/test", 11:20:25 INFO - "buildnumber": 3383, 11:20:25 INFO - "slavename": "talos-linux64-ix-017", 11:20:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:20:25 INFO - "platform": "ubuntu64_hw", 11:20:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:20:25 INFO - "branch": "fx-team", 11:20:25 INFO - "repo_path": "integration/fx-team", 11:20:25 INFO - "revision": "687572ea20cb84f1842ad00dcc8ca1712868a361", 11:20:25 INFO - "stage_platform": "linux64", 11:20:25 INFO - "builduid": "1afea881fd6a40f19b2b70fb36f27acb", 11:20:25 INFO - "slavebuilddir": "test" 11:20:25 INFO - } 11:20:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:20:25 INFO - Running post-action listener: _resource_record_post_action 11:20:25 INFO - [mozharness: 2016-10-11 18:20:25.331094Z] Finished read-buildbot-config step (success) 11:20:25 INFO - [mozharness: 2016-10-11 18:20:25.331183Z] Running download-and-extract step. 11:20:25 INFO - Running pre-action listener: _resource_record_pre_action 11:20:25 INFO - Running main action method: download_and_extract 11:20:25 INFO - mkdir: /builds/slave/test/build/tests 11:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:25 INFO - trying https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:25 INFO - Downloading https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:20:25 INFO - Downloaded 1361 bytes. 11:20:25 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:20:25 INFO - Using the following test package requirements: 11:20:25 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:25 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:20:25 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:20:25 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'jsshell-linux-x86_64.zip'], 11:20:25 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:20:25 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:20:25 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:20:25 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:20:25 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:20:25 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:20:25 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:20:25 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:20:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:20:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:25 INFO - Fetch https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:20:26 INFO - Http code: 200 11:20:26 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 11:20:26 INFO - x-amz-cf-id: MGJqStg4O1Acs3l2s38gVpCYDuBWWGRWN3pdAo1oo3KWvOXGuSl7cg== 11:20:26 INFO - x-amz-version-id: gwCZXwJ7_202QVLeA0qXGNji7GIjEyqj 11:20:26 INFO - Expected file size: 20528991 11:20:26 INFO - Obtained file size: 20528991 11:20:30 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:20:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:20:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:20:30 INFO - Fetch https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:20:31 INFO - Http code: 200 11:20:31 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 11:20:31 INFO - x-amz-cf-id: RHdCTF49X3Ch2pLEtGWIl0lNspgtojQNYMdTE-N9OL0XXY37-SuW_w== 11:20:31 INFO - x-amz-version-id: gwCZXwJ7_202QVLeA0qXGNji7GIjEyqj 11:20:31 INFO - Expected file size: 20528991 11:20:31 INFO - Obtained file size: 20528991 11:20:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:20:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:20:36 INFO - Fetch https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:20:36 INFO - Http code: 200 11:20:36 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:20:36 INFO - x-amz-cf-id: N6DPJVdCTkBFTwnfmn1dtrwAH5oOOq1FM2QHMi6gLx-4LCA7RcDL8Q== 11:20:36 INFO - x-amz-version-id: 2tM85NsNg6pn0nZMeumU0Eg8937mAx7W 11:20:36 INFO - Expected file size: 14409006 11:20:36 INFO - Obtained file size: 14409006 11:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:37 INFO - trying https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:37 INFO - Downloading https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:20:38 INFO - Downloaded 55899915 bytes. 11:20:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:38 INFO - mkdir: /builds/slave/test/properties 11:20:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:38 INFO - Contents: 11:20:38 INFO - build_url:https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:20:38 INFO - Running post-action listener: _resource_record_post_action 11:20:38 INFO - Running post-action listener: set_extra_try_arguments 11:20:38 INFO - [mozharness: 2016-10-11 18:20:38.977716Z] Finished download-and-extract step (success) 11:20:38 INFO - [mozharness: 2016-10-11 18:20:38.977941Z] Running populate-webroot step. 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: populate_webroot 11:20:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:38 INFO - '--tppagecycles', 11:20:38 INFO - '7'], 11:20:38 INFO - 'tests': ['tsvgm']}}, 11:20:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:20:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:20:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:20:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['damp', 'tps']}, 11:20:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'tests': ['damp', 'tps']}, 11:20:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['dromaeo_dom']}, 11:20:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['basic_compositor_video']}, 11:20:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:20:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['a11yr', 11:20:38 INFO - 'ts_paint', 11:20:38 INFO - 'tpaint', 11:20:38 INFO - 'sessionrestore', 11:20:38 INFO - 'sessionrestore_no_auto_restore', 11:20:38 INFO - 'tabpaint']}, 11:20:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['tsvgx', 11:20:38 INFO - 'tsvgr_opacity', 11:20:38 INFO - 'tart', 11:20:38 INFO - 'tscrollx', 11:20:38 INFO - 'cart']}, 11:20:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:20:38 INFO - 'tsvgr_opacity', 11:20:38 INFO - 'tart', 11:20:38 INFO - 'tscrollx', 11:20:38 INFO - 'cart']}, 11:20:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'talos_options': ['--disable-e10s'], 11:20:38 INFO - 'tests': ['tp5o']}, 11:20:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'tests': ['tp5o']}, 11:20:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'talos_options': ['--disable-e10s', 11:20:38 INFO - '--xperf_path', 11:20:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:38 INFO - 'tests': ['tp5n']}, 11:20:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:38 INFO - 'talos_options': ['--xperf_path', 11:20:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:38 INFO - 'tests': ['tp5n']}}, 11:20:38 INFO - 'talos.zip': {'path': '', 11:20:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:38 INFO - Running post-action listener: _resource_record_post_action 11:20:38 INFO - [mozharness: 2016-10-11 18:20:38.999884Z] Finished populate-webroot step (success) 11:20:38 INFO - [mozharness: 2016-10-11 18:20:38.999971Z] Running create-virtualenv step. 11:20:39 INFO - Running pre-action listener: _resource_record_pre_action 11:20:39 INFO - Running main action method: create_virtualenv 11:20:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:39 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 11:20:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:39 INFO - Using real prefix '/usr' 11:20:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:39 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:41 INFO - Installing pip.................done. 11:20:41 INFO - Return code: 0 11:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:20:41 INFO - Reading from file tmpfile_stdout 11:20:41 INFO - Output received: 11:20:41 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) 11:20:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:41 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')]} 11:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 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')]} 11:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:41 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:41 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 11:20:41 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 11:20:41 INFO - Using env: {'DISPLAY': ':0', 11:20:41 INFO - 'HOME': '/home/cltbld', 11:20:41 INFO - 'LANG': 'en_US.UTF-8', 11:20:41 INFO - 'LANGUAGE': 'en_US:en', 11:20:41 INFO - 'LOGNAME': 'cltbld', 11:20:41 INFO - 'MAIL': '/var/mail/cltbld', 11:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:41 INFO - 'MOZ_NO_REMOTE': '1', 11:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:41 INFO - 'NO_EM_RESTART': '1', 11:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:41 INFO - 'PWD': '/builds/slave/test', 11:20:41 INFO - 'SHELL': '/bin/bash', 11:20:41 INFO - 'SHLVL': '1', 11:20:41 INFO - 'TERM': 'linux', 11:20:41 INFO - 'TMOUT': '86400', 11:20:41 INFO - 'USER': 'cltbld', 11:20:41 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:41 INFO - '_': '/tools/buildbot/bin/python'} 11:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:41 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 11:20:41 INFO - Cleaning up... 11:20:42 INFO - Return code: 0 11:20:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:20:42 INFO - Using env: {'DISPLAY': ':0', 11:20:42 INFO - 'HOME': '/home/cltbld', 11:20:42 INFO - 'LANG': 'en_US.UTF-8', 11:20:42 INFO - 'LANGUAGE': 'en_US:en', 11:20:42 INFO - 'LOGNAME': 'cltbld', 11:20:42 INFO - 'MAIL': '/var/mail/cltbld', 11:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:42 INFO - 'MOZ_NO_REMOTE': '1', 11:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:42 INFO - 'NO_EM_RESTART': '1', 11:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:42 INFO - 'PWD': '/builds/slave/test', 11:20:42 INFO - 'SHELL': '/bin/bash', 11:20:42 INFO - 'SHLVL': '1', 11:20:42 INFO - 'TERM': 'linux', 11:20:42 INFO - 'TMOUT': '86400', 11:20:42 INFO - 'USER': 'cltbld', 11:20:42 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:42 INFO - '_': '/tools/buildbot/bin/python'} 11:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:42 INFO - Downloading/unpacking psutil>=3.1.1 11:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:44 INFO - Installing collected packages: psutil 11:20:44 INFO - Running setup.py install for psutil 11:20:44 INFO - building 'psutil._psutil_linux' extension 11:20:44 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 11:20:44 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 11:20:44 INFO - building 'psutil._psutil_posix' extension 11:20:44 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 11:20:44 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 11:20:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:44 INFO - Successfully installed psutil 11:20:44 INFO - Cleaning up... 11:20:44 INFO - Return code: 0 11:20:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:20:44 INFO - Using env: {'DISPLAY': ':0', 11:20:44 INFO - 'HOME': '/home/cltbld', 11:20:44 INFO - 'LANG': 'en_US.UTF-8', 11:20:44 INFO - 'LANGUAGE': 'en_US:en', 11:20:44 INFO - 'LOGNAME': 'cltbld', 11:20:44 INFO - 'MAIL': '/var/mail/cltbld', 11:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:44 INFO - 'MOZ_NO_REMOTE': '1', 11:20:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:44 INFO - 'NO_EM_RESTART': '1', 11:20:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:44 INFO - 'PWD': '/builds/slave/test', 11:20:44 INFO - 'SHELL': '/bin/bash', 11:20:44 INFO - 'SHLVL': '1', 11:20:44 INFO - 'TERM': 'linux', 11:20:44 INFO - 'TMOUT': '86400', 11:20:44 INFO - 'USER': 'cltbld', 11:20:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:44 INFO - '_': '/tools/buildbot/bin/python'} 11:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:20:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:20:46 INFO - Installing collected packages: mozsystemmonitor 11:20:46 INFO - Running setup.py install for mozsystemmonitor 11:20:47 INFO - Successfully installed mozsystemmonitor 11:20:47 INFO - Cleaning up... 11:20:47 INFO - Return code: 0 11:20:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:20:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:20:47 INFO - Using env: {'DISPLAY': ':0', 11:20:47 INFO - 'HOME': '/home/cltbld', 11:20:47 INFO - 'LANG': 'en_US.UTF-8', 11:20:47 INFO - 'LANGUAGE': 'en_US:en', 11:20:47 INFO - 'LOGNAME': 'cltbld', 11:20:47 INFO - 'MAIL': '/var/mail/cltbld', 11:20:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:47 INFO - 'MOZ_NO_REMOTE': '1', 11:20:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:47 INFO - 'NO_EM_RESTART': '1', 11:20:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:47 INFO - 'PWD': '/builds/slave/test', 11:20:47 INFO - 'SHELL': '/bin/bash', 11:20:47 INFO - 'SHLVL': '1', 11:20:47 INFO - 'TERM': 'linux', 11:20:47 INFO - 'TMOUT': '86400', 11:20:47 INFO - 'USER': 'cltbld', 11:20:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:47 INFO - '_': '/tools/buildbot/bin/python'} 11:20:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:47 INFO - Downloading/unpacking jsonschema==2.5.1 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:49 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:49 INFO - warning: no files found matching '*.txt' 11:20:49 INFO - no previously-included directories found matching 'build' 11:20:49 INFO - no previously-included directories found matching 'dist' 11:20:49 INFO - no previously-included directories found matching '.git*' 11:20:49 INFO - Installing collected packages: jsonschema, functools32 11:20:49 INFO - Running setup.py install for functools32 11:20:49 INFO - warning: no files found matching '*.txt' 11:20:49 INFO - no previously-included directories found matching 'build' 11:20:49 INFO - no previously-included directories found matching 'dist' 11:20:49 INFO - no previously-included directories found matching '.git*' 11:20:49 INFO - Successfully installed jsonschema functools32 11:20:49 INFO - Cleaning up... 11:20:49 INFO - Return code: 0 11:20:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:20:49 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')]} 11:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:49 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')]} 11:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:49 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:49 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 11:20:49 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 11:20:49 INFO - Using env: {'DISPLAY': ':0', 11:20:49 INFO - 'HOME': '/home/cltbld', 11:20:49 INFO - 'LANG': 'en_US.UTF-8', 11:20:49 INFO - 'LANGUAGE': 'en_US:en', 11:20:49 INFO - 'LOGNAME': 'cltbld', 11:20:49 INFO - 'MAIL': '/var/mail/cltbld', 11:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:49 INFO - 'MOZ_NO_REMOTE': '1', 11:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:49 INFO - 'NO_EM_RESTART': '1', 11:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:49 INFO - 'PWD': '/builds/slave/test', 11:20:49 INFO - 'SHELL': '/bin/bash', 11:20:49 INFO - 'SHLVL': '1', 11:20:49 INFO - 'TERM': 'linux', 11:20:49 INFO - 'TMOUT': '86400', 11:20:49 INFO - 'USER': 'cltbld', 11:20:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:49 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:20:50 INFO - Cleaning up... 11:20:50 INFO - Return code: 0 11:20:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:50 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:50 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 11:20:50 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 11:20:50 INFO - Using env: {'DISPLAY': ':0', 11:20:50 INFO - 'HOME': '/home/cltbld', 11:20:50 INFO - 'LANG': 'en_US.UTF-8', 11:20:50 INFO - 'LANGUAGE': 'en_US:en', 11:20:50 INFO - 'LOGNAME': 'cltbld', 11:20:50 INFO - 'MAIL': '/var/mail/cltbld', 11:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:50 INFO - 'MOZ_NO_REMOTE': '1', 11:20:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:50 INFO - 'NO_EM_RESTART': '1', 11:20:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:50 INFO - 'PWD': '/builds/slave/test', 11:20:50 INFO - 'SHELL': '/bin/bash', 11:20:50 INFO - 'SHLVL': '1', 11:20:50 INFO - 'TERM': 'linux', 11:20:50 INFO - 'TMOUT': '86400', 11:20:50 INFO - 'USER': 'cltbld', 11:20:50 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:50 INFO - '_': '/tools/buildbot/bin/python'} 11:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 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 11:20:52 INFO - Downloading docopt-0.6.1.tar.gz 11:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:53 INFO - Running setup.py install for blobuploader 11:20:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:53 INFO - Running setup.py install for requests 11:20:53 INFO - Running setup.py install for docopt 11:20:53 INFO - Successfully installed blobuploader requests docopt 11:20:53 INFO - Cleaning up... 11:20:53 INFO - Return code: 0 11:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:53 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')]} 11:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 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')]} 11:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:53 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:53 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 11:20:53 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 11:20:53 INFO - Using env: {'DISPLAY': ':0', 11:20:53 INFO - 'HOME': '/home/cltbld', 11:20:53 INFO - 'LANG': 'en_US.UTF-8', 11:20:53 INFO - 'LANGUAGE': 'en_US:en', 11:20:53 INFO - 'LOGNAME': 'cltbld', 11:20:53 INFO - 'MAIL': '/var/mail/cltbld', 11:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:53 INFO - 'MOZ_NO_REMOTE': '1', 11:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:53 INFO - 'NO_EM_RESTART': '1', 11:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:53 INFO - 'PWD': '/builds/slave/test', 11:20:53 INFO - 'SHELL': '/bin/bash', 11:20:53 INFO - 'SHLVL': '1', 11:20:53 INFO - 'TERM': 'linux', 11:20:53 INFO - 'TMOUT': '86400', 11:20:53 INFO - 'USER': 'cltbld', 11:20:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:53 INFO - '_': '/tools/buildbot/bin/python'} 11:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:53 INFO - Running setup.py (path:/tmp/pip-Dv9Ao0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:53 INFO - Running setup.py (path:/tmp/pip-2Xd6lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:54 INFO - Running setup.py (path:/tmp/pip-50XN8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:54 INFO - Running setup.py (path:/tmp/pip-tIAj4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:54 INFO - Running setup.py (path:/tmp/pip-Ft5wwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:54 INFO - Running setup.py (path:/tmp/pip-mlUyKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:54 INFO - Running setup.py (path:/tmp/pip-v4hzXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:54 INFO - Running setup.py (path:/tmp/pip-sHe_dM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:54 INFO - Running setup.py (path:/tmp/pip-FPXd_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:54 INFO - Running setup.py (path:/tmp/pip-MWbfNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:54 INFO - Running setup.py (path:/tmp/pip-_FBxPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:54 INFO - Running setup.py (path:/tmp/pip-Wphazt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:54 INFO - Running setup.py (path:/tmp/pip-Apmm1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:54 INFO - Running setup.py (path:/tmp/pip-PJ5UHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:54 INFO - Running setup.py (path:/tmp/pip-iLhs2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:54 INFO - Running setup.py (path:/tmp/pip-5IcYm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:54 INFO - Running setup.py (path:/tmp/pip-mOOE3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:55 INFO - Running setup.py install for manifestparser 11:20:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Running setup.py install for mozcrash 11:20:55 INFO - Running setup.py install for mozdebug 11:20:55 INFO - Running setup.py install for mozdevice 11:20:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Running setup.py install for mozfile 11:20:55 INFO - Running setup.py install for mozhttpd 11:20:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Running setup.py install for mozinfo 11:20:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Running setup.py install for mozInstall 11:20:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:55 INFO - Running setup.py install for mozleak 11:20:55 INFO - Running setup.py install for mozlog 11:20:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Running setup.py install for moznetwork 11:20:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Running setup.py install for mozprocess 11:20:56 INFO - Running setup.py install for mozprofile 11:20:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Running setup.py install for mozrunner 11:20:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Running setup.py install for mozscreenshot 11:20:56 INFO - Running setup.py install for moztest 11:20:56 INFO - Running setup.py install for mozversion 11:20:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:56 INFO - Cleaning up... 11:20:56 INFO - Return code: 0 11:20:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:56 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')]} 11:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:56 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')]} 11:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:56 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:20:56 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 11:20:56 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 11:20:56 INFO - Using env: {'DISPLAY': ':0', 11:20:56 INFO - 'HOME': '/home/cltbld', 11:20:56 INFO - 'LANG': 'en_US.UTF-8', 11:20:56 INFO - 'LANGUAGE': 'en_US:en', 11:20:56 INFO - 'LOGNAME': 'cltbld', 11:20:56 INFO - 'MAIL': '/var/mail/cltbld', 11:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:56 INFO - 'MOZ_NO_REMOTE': '1', 11:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:56 INFO - 'NO_EM_RESTART': '1', 11:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:56 INFO - 'PWD': '/builds/slave/test', 11:20:56 INFO - 'SHELL': '/bin/bash', 11:20:56 INFO - 'SHLVL': '1', 11:20:56 INFO - 'TERM': 'linux', 11:20:56 INFO - 'TMOUT': '86400', 11:20:56 INFO - 'USER': 'cltbld', 11:20:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:56 INFO - '_': '/tools/buildbot/bin/python'} 11:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:57 INFO - Running setup.py (path:/tmp/pip-UcOv3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:57 INFO - Running setup.py (path:/tmp/pip-GhIWdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:57 INFO - Running setup.py (path:/tmp/pip-S9GiaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:57 INFO - Running setup.py (path:/tmp/pip-LK5cIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:57 INFO - Running setup.py (path:/tmp/pip-ng81pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:57 INFO - Running setup.py (path:/tmp/pip-UQC7xI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:57 INFO - Running setup.py (path:/tmp/pip-9ZK7Lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:57 INFO - Running setup.py (path:/tmp/pip-j2gK9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:57 INFO - Running setup.py (path:/tmp/pip-T2cq_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:57 INFO - Running setup.py (path:/tmp/pip-G6ZEOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:57 INFO - Running setup.py (path:/tmp/pip-FQtQrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:57 INFO - Running setup.py (path:/tmp/pip-kLGNLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:57 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)) 11:20:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:57 INFO - Running setup.py (path:/tmp/pip-aa0glQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:58 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)) 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:58 INFO - Running setup.py (path:/tmp/pip-_gTzTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:58 INFO - Running setup.py (path:/tmp/pip-PNxM4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:58 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)) 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:58 INFO - Running setup.py (path:/tmp/pip-LnP94o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:58 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)) 11:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:58 INFO - Running setup.py (path:/tmp/pip-_xUip5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:58 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)) 11:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:20:58 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)) 11:20:58 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)) 11:20:58 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)) 11:20:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:58 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 11:20:58 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 11:20:58 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 11:20:58 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 11:20:58 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 11:20:58 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 11:21:00 INFO - Downloading blessings-1.6.tar.gz 11:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:21:00 INFO - Installing collected packages: blessings 11:21:00 INFO - Running setup.py install for blessings 11:21:00 INFO - Successfully installed blessings 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:21:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:00 INFO - Reading from file tmpfile_stdout 11:21:00 INFO - Current package versions: 11:21:00 INFO - argparse == 1.2.1 11:21:00 INFO - blessings == 1.6 11:21:00 INFO - blobuploader == 1.2.4 11:21:00 INFO - docopt == 0.6.1 11:21:00 INFO - functools32 == 3.2.3-2 11:21:00 INFO - jsonschema == 2.5.1 11:21:00 INFO - manifestparser == 1.1 11:21:00 INFO - mozInstall == 1.12 11:21:00 INFO - mozcrash == 0.17 11:21:00 INFO - mozdebug == 0.1 11:21:00 INFO - mozdevice == 0.48 11:21:00 INFO - mozfile == 1.2 11:21:00 INFO - mozhttpd == 0.7 11:21:00 INFO - mozinfo == 0.9 11:21:00 INFO - mozleak == 0.1 11:21:00 INFO - mozlog == 3.4 11:21:00 INFO - moznetwork == 0.27 11:21:00 INFO - mozprocess == 0.23 11:21:00 INFO - mozprofile == 0.28 11:21:00 INFO - mozrunner == 6.12 11:21:00 INFO - mozscreenshot == 0.1 11:21:00 INFO - mozsystemmonitor == 0.3 11:21:00 INFO - moztest == 0.7 11:21:00 INFO - mozversion == 1.4 11:21:00 INFO - psutil == 3.1.1 11:21:00 INFO - requests == 1.2.3 11:21:00 INFO - wsgiref == 0.1.2 11:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:21:00 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 11:21:00 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 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 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)) 11:21:00 INFO - Cleaning up... 11:21:00 INFO - Return code: 0 11:21:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:21: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')]} 11:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21: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')]} 11:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:21:00 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 0x7fa1ec6b8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1720ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, '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': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', '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 11:21:00 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 11:21:00 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 11:21:00 INFO - Using env: {'DISPLAY': ':0', 11:21:00 INFO - 'HOME': '/home/cltbld', 11:21:00 INFO - 'LANG': 'en_US.UTF-8', 11:21:00 INFO - 'LANGUAGE': 'en_US:en', 11:21:00 INFO - 'LOGNAME': 'cltbld', 11:21:00 INFO - 'MAIL': '/var/mail/cltbld', 11:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:00 INFO - 'MOZ_NO_REMOTE': '1', 11:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:00 INFO - 'NO_EM_RESTART': '1', 11:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:00 INFO - 'PWD': '/builds/slave/test', 11:21:00 INFO - 'SHELL': '/bin/bash', 11:21:00 INFO - 'SHLVL': '1', 11:21:00 INFO - 'TERM': 'linux', 11:21:00 INFO - 'TMOUT': '86400', 11:21:00 INFO - 'USER': 'cltbld', 11:21:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:00 INFO - '_': '/tools/buildbot/bin/python'} 11:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:21:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:21:01 INFO - Cleaning up... 11:21:01 INFO - Return code: 0 11:21:01 INFO - Running post-action listener: _resource_record_post_action 11:21:01 INFO - Running post-action listener: _start_resource_monitoring 11:21:01 INFO - Starting resource monitoring. 11:21:01 INFO - [mozharness: 2016-10-11 18:21:01.242932Z] Finished create-virtualenv step (success) 11:21:01 INFO - [mozharness: 2016-10-11 18:21:01.243434Z] Running install step. 11:21:01 INFO - Running pre-action listener: _resource_record_pre_action 11:21:01 INFO - Running main action method: install 11:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:21:01 INFO - Reading from file tmpfile_stdout 11:21:01 INFO - Detecting whether we're running mozinstall >=1.0... 11:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:21:01 INFO - Reading from file tmpfile_stdout 11:21:01 INFO - Output received: 11:21:01 INFO - Usage: mozinstall [options] installer 11:21:01 INFO - Options: 11:21:01 INFO - -h, --help show this help message and exit 11:21:01 INFO - -d DEST, --destination=DEST 11:21:01 INFO - Directory to install application into. [default: 11:21:01 INFO - "/builds/slave/test"] 11:21:01 INFO - --app=APP Application being installed. [default: firefox] 11:21:01 INFO - mkdir: /builds/slave/test/build/application 11:21:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:21:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:21:17 INFO - Reading from file tmpfile_stdout 11:21:17 INFO - Output received: 11:21:17 INFO - /builds/slave/test/build/application/firefox/firefox 11:21:17 INFO - Running post-action listener: _resource_record_post_action 11:21:17 INFO - [mozharness: 2016-10-11 18:21:17.695393Z] Finished install step (success) 11:21:17 INFO - [mozharness: 2016-10-11 18:21:17.695636Z] Running run-tests step. 11:21:17 INFO - Running pre-action listener: _resource_record_pre_action 11:21:17 INFO - Running main action method: run_tests 11:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:21:17 INFO - Python 2.7.3 11:21:17 INFO - Return code: 0 11:21:17 INFO - grabbing minidump binary from tooltool 11:21:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:21:17 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 0x171df60>, '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 0x171ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x171f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:21:17 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 11:21:17 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 11:21:17 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 11:21:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:21:17 INFO - Return code: 0 11:21:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:21:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:21:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:21:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:21:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:21:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 11:21:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 11:21:17 INFO - Using env: {'DISPLAY': ':0', 11:21:17 INFO - 'HOME': '/home/cltbld', 11:21:17 INFO - 'LANG': 'en_US.UTF-8', 11:21:17 INFO - 'LANGUAGE': 'en_US:en', 11:21:17 INFO - 'LOGNAME': 'cltbld', 11:21:17 INFO - 'MAIL': '/var/mail/cltbld', 11:21:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:21:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:21:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:21:17 INFO - 'MOZ_NO_REMOTE': '1', 11:21:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:21:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:21:17 INFO - 'NO_EM_RESTART': '1', 11:21:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:21:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:21:17 INFO - 'PWD': '/builds/slave/test', 11:21:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:21:17 INFO - 'SHELL': '/bin/bash', 11:21:17 INFO - 'SHLVL': '1', 11:21:17 INFO - 'TERM': 'linux', 11:21:17 INFO - 'TMOUT': '86400', 11:21:17 INFO - 'USER': 'cltbld', 11:21:17 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393', 11:21:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:21:17 INFO - '_': '/tools/buildbot/bin/python'} 11:21:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 11:21:17 INFO - mozversion application_buildid: 20161011094846 11:21:17 INFO - mozversion application_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 11:21:17 INFO - mozversion application_display_name: Nightly 11:21:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:21:17 INFO - mozversion application_name: Firefox 11:21:17 INFO - mozversion application_remotingname: firefox 11:21:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:21:17 INFO - mozversion application_vendor: Mozilla 11:21:17 INFO - mozversion application_version: 52.0a1 11:21:17 INFO - mozversion platform_buildid: 20161011094846 11:21:17 INFO - mozversion platform_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 11:21:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:21:17 INFO - mozversion platform_version: 52.0a1 11:21:17 INFO - using testdate: 1476210077 11:21:17 INFO - actual date: 1476210077 11:21:17 INFO - starting webserver on 'localhost:51136' 11:21:17 INFO - SUITE-START | Running 2 tests 11:21:17 INFO - TEST-START | dromaeo_css 11:21:17 INFO - operating with platform_type : linux_ 11:21:17 INFO - Initialising browser for dromaeo_css test... 11:21:17 INFO - TEST-INFO | started process 8725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uxugK/profile http://localhost:51136/getInfo.html) 11:21:22 INFO - PROCESS | 8725 | __metrics Screen width/height:1600/1200 11:21:22 INFO - PROCESS | 8725 | colorDepth:24 11:21:22 INFO - PROCESS | 8725 | Browser inner width/height: 1024/697 11:21:22 INFO - PROCESS | 8725 | __metrics 11:21:22 INFO - PROCESS | 8725 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:21:22 INFO - PROCESS | 8725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:21:23 INFO - PROCESS | 8725 | console.error: PushService: 11:21:23 INFO - PROCESS | 8725 | stateChangeProcessEnqueue: Error transitioning state 11:21:23 INFO - PROCESS | 8725 | UnknownError 11:21:23 INFO - TEST-INFO | 8725: exit 0 11:21:23 INFO - Browser initialized. 11:21:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:21:23 INFO - TEST-INFO | started process 8809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2uxugK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:21:36 INFO - PROCESS | 8809 | RSS: Main: 174673920 11:21:36 INFO - PROCESS | 8809 | 11:22:27 INFO - PROCESS | 8809 | 1476210147777 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] 11:24:41 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51136/tests/dromaeo/cssquery-ext.html) 11:24:42 INFO - PROCESS | 8809 | RSS: Main: 292040704 11:24:42 INFO - PROCESS | 8809 | 11:27:45 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-ext.html (next: http://localhost:51136/tests/dromaeo/cssquery-jquery.html) 11:27:45 INFO - PROCESS | 8809 | RSS: Main: 274907136 11:27:45 INFO - PROCESS | 8809 | 11:30:47 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51136/tests/dromaeo/cssquery-mootools.html) 11:30:48 INFO - PROCESS | 8809 | RSS: Main: 243728384 11:30:48 INFO - PROCESS | 8809 | 11:33:50 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51136/tests/dromaeo/cssquery-prototype.html) 11:33:51 INFO - PROCESS | 8809 | RSS: Main: 236720128 11:33:51 INFO - PROCESS | 8809 | 11:36:54 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51136/tests/dromaeo/cssquery-yui.html) 11:36:55 INFO - PROCESS | 8809 | RSS: Main: 219893760 11:36:55 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | Cycle 1(1): loaded http://localhost:51136/tests/dromaeo/cssquery-yui.html (next: http://localhost:51136/tests/dromaeo/cssquery-dojo.html) 11:39:58 INFO - PROCESS | 8809 | RSS: Main: 311046144 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | __start_tp_report 11:39:58 INFO - PROCESS | 8809 | _x_x_mozilla_page_load 11:39:58 INFO - PROCESS | 8809 | _x_x_mozilla_page_load_details 11:39:58 INFO - PROCESS | 8809 | |i|pagename|runs| 11:39:58 INFO - PROCESS | 8809 | |0;dojo.html;2525.7095434025086;2560.3471114865706;2574.253466494716;2595.8182927195103;2605.0751983046016;4525.140223357568;4637.443506779183;4716.528347165282;4720.409948756405;4740.146773580754;4612.953870461294;4620.976895115528;4636.721796692193;4671.439427268732;4729.597984171341;4233.618974292313;4302.677299202556;4334.718243314191;4361.476622805268;4362.0621566363225;4344.02259491615;4379.299312110063;4396.670249731283;4412.75729834859;4461.598456138947;4200.873973780792;4365.476142862845;4376.89057773555;4402.537733537981;4464.6651501137385;4245.193413251503;4265.55211702773;4288.52826189119;4323.2218200723855;4329.982454123278;4266.040140968288;4287;4299.892502687427;4340.045190058182;4344.761038142901;4657.068586282757;4664;4685.086408150412;4696.765161741933;4706.717596944194;4814.566688997972;4869.050535145648;4871.805127794884;4933.1860243059855;4995.700257984533;5009.674371165863;5040.899182016376;5052.797888084509;5077.035363280965;5105.744712764347;4686.906261874743;4689.8358557450665;4690.202665546865;4695.741734204583;4746.335513028179;4922.950770492321;4945.431275403303;5142.434332223453;5145.742712864342;5204.1673332266655;4770.284457331359;4796;4869.70781753096;4924.3352147460355;5009.674371165863;5012.423571289275;5015.724135172601;5022.246663000579;5027.069992051483;5088.92366614501;4934.087193869145;4957.107720610253;4965.652404331734;4982.327385802942;5046.990601879639;4816.566509014206;4875.512448755097;4879.194932836042;4899.632527560448;4932.013597280558;4293.677974151951;4295.52749197588;4295.935560966588;4296.033392486665;4299.419578356944;3712.9071773205346;3719.8326075326677;3725.5529336479794;3795.1271207622403;3813.7139714520968;4307;4310.396544483775;4311.267084595626;4363.650907927358;4366.14860102277;4981;4984.152694041949;4988.72562009093;4992.625553083533;5049.192129259301;4205.201011807747;4253.340732186516;4273.850415235452;4304.139172165579;4314.956850431518;4528.637708983273;4529.750863702462;4529.750863702462;4583.633309335245;4588.7935042923145;4630.32860235264;4650.953490465052;4651.898734177295;4657.5575320344515;4734.786934588021;4820.325154478306;4830;4888.388951380935;4995.375578052744;5008.323876276656;4579.06129243511;4582.1293954148605;4595.885102872455;4597.632189424905;4598.172328980816;4856.562909338177;4870.220764677776;4871.610271178368;4883.8290659826735;4901.975490122669;5010.549050585465;5012.949870501394;5059.87350316245;5069.7465126744255;5073.568746656576;4868.853934381974;4877.975610121926;4879.658423910434;4886.071646387317;4948.084604348207;4737.8341758038305;4795.832145875017;4872.585830204473;4877.463479017376;4891.706497610155;4713.505081966344;4736.763161841825;4753.049390122059;4779.737114458738;4784.425868895755;4887.511248875084;4889.877753056202;4897.804087836446;4941.530554597308;4956.504349565014;4773.570378665937;4774.116788394158;4777.904441911072;4833.323334733211;4836.226203807374 11:39:58 INFO - PROCESS | 8809 | |1;ext.html;551.5008916930178;568.0230004392446;574.4169667787199;578.866860622057;581.1254062635733;27501.587476187873;28134.859325703368;30062.849685751597;30133.246668833235;30160.09519714409;29704.702952970463;37892;38792.80603596985;39069.21861562767;42546.7872660637;7617.46677732559;7752.379809615217;7762.146163921964;7764.689412423496;7768.650410731502;7656.3874890008665;7751.573663448508;7756.612169391536;7757.612119394008;7759.224077592224;7758.418118641124;7786.571738554378;7787.182345853689;7797.415193860455;7799.883001754978;7723.2662897024975;7773.494722843054;7778.961105194495;7784.688612455467;7794.961025194894;7727.343175830061;7738.303552680286;7752.573608451533;7796.259355361231;7798.103218129931;35321.29357412863;35586;35606.287874242626;35665;35785.46321805149;2840.247334456371;2926.897558585439;2969.317057076863;3076.969230307691;3410.198603328216;27042.188734338;27393.31516712078;27883.302917427023;28098.157055288375;28150.43699126006;3131.3424180922034;3160.98419507901;3210.598675165604;3350.7654464187517;3365.528825964367;250478;250999;250999;252376;252996;49973.50026499761;50219.49780502221;50336.24495632568;50357.74821125871;55210.447895521334;52613.7369313151;58327.4167258322;58330;58347.41652583505;58439.415605844246;14903.850961490463;15119.470818521298;15124.697506049817;15140.318685659171;15150.696986060217;11100.278481898651;11307.038901693284;11331.886681133248;11335.773284534263;11419.543218271176;15855.682886342209;16307.59231019234;18361;18433.26266949334;18508.81491185071;6805.183377994672;6827.351401616838;7028.92971070293;7086.574805511686;7223.916412538161;777.941654375924;825.8554752918216;839.131498898637;966.4056605187759;988.4168340679034;25529.744702552736;27423.04019359313;27515.724842751715;27962.300942476195;28122.156335309974;869.5652173913044;941.6280569175275;942.7360339105062;962.5139304651107;1033.121846430528;13609.387577559033;14549.92725036368;14575.956752874989;14611.707765844623;14734.778978315333;376131;376491;376613;377304;378698;41588.79205603953;42381.15237695229;47182.5281747185;48120.51879481161;48601.27098093531;1120.882307357732;1160.5589875847124;1163.552032467506;1168.9123315751183;1177.2628638415547;27380.315492112855;27603.44793104167;28340;28947.56578651364;28993;41107.177856443304;41423.7928810354;41556.792216038724;41562.50624962512;41608.375874362515;318338;359287;367892;368528;561137;36663.816680916425;37031.2226583002;37190.44214336841;37394.62605373911;37814;40031.99920002023;40848.38727419032;41060.38409423801;41156.79421602873;41559.1688166241;35098.29803403969;35126;35201.47197791984;35598.28803423865;35792.64207357893;35355;35507.64492355043;35662.64337356593;35983;36022.63977360193;33631.66368336285;34003.319933601684;34122.48816267708;34410.655893440744;35141.12147196341;29532.852335738186;31484;31545.8422707885;31802.204944876565;31821.681783181873;24268.75731242665;24364.26907192787;24382.75617243805;24473.38816529601;24590.508189835746 11:39:58 INFO - PROCESS | 8809 | |2;jquery.html;326.72228605685154;338.0332249765671;353.9150603855075;354.75521889895964;376.78711527986684;12125.696857578565;16419.34322627095;16617.252223649935;16954.152292385363;17104.401345952894;15960.920195399036;16181.110038947852;16474;16665.91667041666;16684.749728754046;3895.7857317847506;4880.707157570549;5104.438511763703;5118.718470484122;5170.146925757245;5009.899802003958;5041.571466425358;5041.6722913010535;5048.318477005612;5050.494950504957;4833.105875413043;4997.250412438145;5001.249812528132;5001.8249361272365;5053.494650534935;4946.40643122824;4982.427020892607;4993.575546078588;4996.225585034307;5007.2989781430815;4330.870073897788;4480.775961201927;4516.751578663172;4518.299663552155;4525.072360166191;19840;19851.50371240716;19958.80041199584;20036;20202.191912323637;1914.1099388784282;1922.480930148866;1974.8025197480138;2059.6910463430604;2303.1823702585507;12366;12733.490660373574;12960.870391296061;13328.733425331438;13475.663108422368;1642.5729310379388;1675.1205617051023;1695.7371607400873;1706.6416052628963;1789.5168304557826;65069;67053.32946670569;67683.66158169227;67798.32201678019;67889;9053.321000924958;9085.091490850862;9370.953145234367;9398.48308343034;9718.368306060083;13333.200007999358;13338.333083345988;13340.132891362224;13350.799738003938;13351.399187036606;7094;7137.393321567621;7274.418046556263;7337.119545654449;7356;6841.931580684229;6927.411170050501;6969;7064.646767661597;7145;5718.512447085448;5799.39106393831;5803.8549036274435;5929.703514824241;6012.534860707089;1572.2060359518598;1611.9597010074608;1675.1289329548567;1724.9310027599006;1761.4275360507886;682.2461180395691;861.1646702698373;866.9176428239307;890.3189060368823;907.5190149220923;16109.597260068593;16433.685305175557;16892.239849206817;17228.138593070296;17331.30674772995;840.9243168114776;854.9401541892132;861.173273657296;869.7738587967048;883.7172104926491;9334.253259739204;9751.122398984126;9932.205423566098;9957.125741388087;10077.69766906994;298859;299630;301323;382237;383097;80346.59826700829;82895.585522072;83378.58310708408;84727.15272847316;87034;866.7226487523932;891.9937639373969;903.4488961733338;908.9000209976897;910.4127837544879;14754.704905902037;15029.774553381927;15743.606409839387;15787.526374208792;16069.955452895525;34812.65187348094;35477.46783798194;35772.4634130483;35888.64111358853;36974.44538331981;45418.54581454143;47067;51570;51916.48083519116;52801.94396112133;7110.680019399243;7271.8909216360735;7345.706171753283;7540.8491830164185;7550.2072282411755;10579.576816927545;10618.575256989943;10788.29876058085;10819.67540973772;11113.666590002313;8546.829063418822;8746.38775285724;9405.341626086109;9489.762755931157;9747;9346;9515.429074255568;9521.904780952102;9634.181094607036;10051.748706282402;8920.464772113693;9202.677906273248;9240.630374784932;9485.098915603006;9597.136257736836;7101.609411482212;7360.822268437024;7422.294881986203;7507.474476786572;7545.320921117126;7723.382129429745;8965.820683586162;8997.145271199226;9501.049895010443;9806 11:39:58 INFO - PROCESS | 8809 | |3;mootools.html;1333.513267657305;1371.7805151175814;1412.3150272118028;1648.3159488812144;1657.328781843353;6507.6420796856155;6737.124173857392;7121.145462544496;7726.961365193173;7728.96135519323;7122.96438517808;7421.703131874719;7436.293552112541;7609.467337286392;7646.311831935125;2123.915043398266;2146.6028784674886;2150.118451434912;2151;2153.3001774423374;1766.8321509456582;1839.301065595072;2104.084723145437;2131.7868213178635;2147.76374598794;2042.1320938601036;2101.8003289687454;2109.103630956845;2116.4285642876416;2121.098533123424;2083.1771450277206;2090.0385822521657;2095.8847263400507;2111.5852378906093;2114.7779483154277;2082.2191678120703;2100.327895073577;2101.0335245786955;2101.2645574049116;2106.273335699181;7543.69825206991;7545.547267163988;7599.35405490534;7650.770476885702;7651.081870175559;4437.356583295404;4576.473705523874;4577.519360467137;4579.244424669925;4582.175208462475;2625.671791026122;2780.457810726909;2821.746042856132;2838.403935173616;2848.51575232211;864.8183881384854;865.9393842431033;871.1488087813397;884.9115088491163;887.8268737596171;10132.746681332952;10142.391456512632;10160.847587286196;10160.847587286196;10164.085232329053;3786.1481166737262;3881.8641347553266;4049.2913740095364;4086.244044851712;4091.0590564170407;8759.34304927133;8761.34289928258;8789.296856251613;8789.824203516022;8792.208701216921;4522.276435770261;4527.139843429738;4530.841420550265;4534.115847409789;4537.455505339314;4033.495813023372;4112.876613701594;4127.484064491939;4128.793560321972;4130.896727581774;3547.8758243461357;3579.6420357964516;3646.690031347365;3661.377565813818;3700.16746232101;1072.3351522056219;1113.8663360396804;1175.5767923547517;1181.4211036592008;1195.7967145585271;658.9538732288694;722.2596838240845;722.3498851034111;746.7050515046526;817.9427440079256;4770.785314660849;4989.625778066659;5037.622178336639;5056.974715126475;5217.686938783685;810.6757297081097;832.2010869565164;834.486790623762;867.7353407210735;897.1566727276339;3240.3357311751033;3346.498025296225;3443.104792753852;3458.9308213835584;3508.824558772102;8944.8658270126;9239.39943903644;9241.399309044891;9247.630094796268;9252.259819214447;8451.704190353308;9099.545022748836;9177.724668259963;9196.264298856075;9232.076792320715;6729.4279986200745;7076.681549330293;7077.893831592531;7083.433325333961;7086.681099350439;4826.493218212037;4997.175466048061;5001.799928002984;5019.7239151847;5157.535821776059;7954.602269886367;8077.474964127313;8081;8199.549024803693;8221.630026648696;8165.224303691378;8408.159184081544;8466.91533084686;8472.322214222724;8475.618597163018;6637.2699003108655;6761.222459417033;6762.763303284361;6765;6765.492588055817;7172.856542869009;7180.533265337736;7192.604406757469;7247.9637601813765;7285.344319011315;5393.8112166074;6479.384458476437;6518.934810651833;6525.771597994048;6618.172728408949;6486.3513648636645;6592.307807680317;6619.470442364695;6634.966825165843;6643.800685979429;6156.78451254204;6271.216097987752;6273.341299163704;6281.497480201664;6283.905741413974;4184.142250838631;4185.246655602021;4237.87286381409;4244.3633454982;4365.061511774984;4158.531531036798;4177.12280421115;4207.389928460418;4272.166927449118;4299.785010749512 11:39:58 INFO - PROCESS | 8809 | |4;prototype.html;292.8155262184823;293.2873118322476;304.7455374762074;306.50040434092426;308.5156304601776;4788.880277993043;4885.609151267899;4925.507449255073;4942.777575009129;4970.887372866531;4697.929531057029;4804.711717296965;4807;4819.638527110464;4885.633577481694;3874.8256328465145;3880.5343358796986;3889.844406223762;3892.82482288297;3898.200868821899;3645.3073915956015;3887.844486220562;3905.902352441183;3919.8628048018327;3921.627430399366;3578.870572009663;3800.6769424598942;3818.8281527331337;3831.865884694036;3865.942010869839;3853.2871418787613;3862.1696335288048;3862.80685965702;3863.652271295569;3866.839948015598;3423.1442139465134;3426.509468381237;3434.347473979961;3436.415809312398;3437.071990562534;4561.2245918193985;4759.452662943737;4765;4801.68789028712;4818.927716084261;4321.308590625485;4344.89137771555;4347.239233134221;4347.69566130371;4351.8476853309985;5101.183810590288;5115;5141.632230888737;5177.291493807034;5182.896342073137;3420;3611.837467313951;3616.4032934565766;3621.692156166729;3657.5428071491065;5303.946960530384;5313.681179129226;5318.813841515567;5328.6269961102735;5342.492463215988;3728.366177749789;3731.1604888900324;3732.9813350933073;3735.533058367704;3743.9251214975548;3751.2872554214614;3753.530808648919;3763.209725957525;3763.6048214937587;3766.1902690921033;4212.241796476603;4260.531341552427;4277.144571085795;4300.978495107504;4311.590398912098;5030.4215015272985;5048.0913435581215;5049.358958338481;5058.898822023539;5084.237364395371;1199.1366216324407;1239.7148655809035;1284.0867108009186;1288.6134159752037;1303.1138825598684;849.3375167369462;877.2105105405059;877.6489404238229;889.644142343055;892.6786356911507;4471.323253779832;4485.887852803706;4495.550444955544;4501.842435514741;4514.88712782183;5239.161734122522;5254.159334506537;5258.579313654898;5264.736763161826;5264.736763161826;4391.978040109843;4471.217536931024;4488.236999710057;4492.7311707588115;4517.006258623098;2757.3658058646624;2762.2597763408926;2775.4310366374843;2777.5694767311097;2780.138157171283;4849.2968519565175;4881.145799485076;4881.243407271879;4885.706857588485;4888.169011268093;5139.434662187156;5384.9461505385225;5391.81128660495;5413.593980451482;5426.945730542723;4948.579370753454;4964.081644895634;4967.503249675004;4971.975140124348;4984.22744474607;5032.6225533084435;5303.390110137384;5310.920336195038;5324.8136315228785;5327.334083239595;5205.973970130125;5219.929914367622;5219.947800521946;5220.120756527571;5243.921341179962;4927.384076990376;4972.229304457815;5002.274670172732;5057.6459647824295;5059.3169922061525;3555.306715190513;3751.887443376594;3763.9059023524633;3772.6981841453166;3775.867844625425;5218.347706536683;5235.476452354734;5237.502437268454;5299.814506492408;5312.946870531246;5078.695278283315;5082.932584157368;5113.15632920564;5147.356580427447;5175.353080864892;4917.598484432063;5079.822206222764;5146.897062058663;5149.562287205629;5173.1893837156695;4825.782839772149;4973.577245934136;5008.3238762768015;5045.293658887832;5048.646594738333;5009.699418034929;5170.896582068262;5191.662541934762;5212.765425555784;5215.478452154906;5070.163423035306;5073;5078.4921507850395;5106.310648062613;5132.79468821243 11:39:58 INFO - PROCESS | 8809 | |5;yui.html;600.2916558461015;605.2192671453828;663.8738639658463;673.135021497376;675.2032601530195;12494.562690305842;12926.741465170691;13375.665608359795;13645.113067650607;13663.453461861514;13081.28052957087;13295.867041329584;13350.399232034557;13353.198808071498;13355.198688078723;602.8191542537244;623.8814625221216;737.4248086492518;757.1822431773671;760.3423039071191;726.3898325406657;751.8345963887936;753.2542782645169;754.7358424551418;755.0260164387932;803.2008151888879;803.4817542684965;804.9919500805005;805.4603415711488;805.9798505037392;628.3936001758325;648.0894343447417;794.972175973841;795.0141824138057;795.9442839001272;479.82966047053145;480.20046622373707;480.27718283982733;561.7668667502982;578.3580225949192;12606;12637.684057898534;12643.304618245993;12653.430595623218;12667.61997140078;11729.354885481294;11753.236039657395;11890;12042.096842736742;12778.424970876333;11173.72065698356;11223.913151241743;11332.490037948312;11452.255603385753;11534.423278836024;3930.7051971102283;3985.7807820569856;4064.8577299794365;4125.66994640431;4150.667946564267;59178.70410647919;62074.689626552026;62330.68834655843;62358;63442.68278658577;9231.90768092324;9271.490068046187;9364.578593963288;9437.103475169848;9637.325387222827;17732.822671773374;17764.934103953805;17807.19867605961;17826.37607683725;17844;6125.632462052291;6131.448169664752;6251;6261.123442718023;6294.905576416358;3347.0962840033053;3458.3774920514547;3502.8949131526097;3512.473129030615;3535;2713.769329606966;2773.597828314883;2809.185336252464;2819.323362393011;3045.5279431688123;543.9728013599304;544.3386285662939;551.969641669712;553.7701853730737;562.8508445262008;530.973451327432;545.165896178847;593.5904226083989;602.8703828676855;614.1248720573166;8108.8378232435025;8217.506949583045;8253.257206851413;8379.958100209582;8674.038653118127;491.00571343029935;549.2859282932172;570.9209593867594;607.8055022392792;608.5861614102364;3869.1294458746556;3956.7625942443547;3986.282469155522;4156.236341240482;4175.123224122907;53680.73159634177;60887.69556152191;98509;100166.4991675037;102178.48910755548;83675;83813.58093209495;84102.57948710218;85312;85372.57313713516;72827.63586182035;74513.25486745172;75981.24018759852;75989.24010759933;77032.61483692657;7781.844363112593;7905.446618736633;7946.364290856834;8011.599420029092;8244.093149753402;29128.12615621535;35884.64115358813;37583.43624845684;40293.39559906545;42152.78923605485;34338.31323373569;36397.636023639425;36999.63000369962;47530.52469475399;50716.49283507118;11488.138389620979;11532.481038353462;11642;11893.881061189277;11906.76186476283;12683.175593586388;12774.61676149717;12836.16564923277;13245.602631921058;13459.05786594929;11299.491522881655;11303.71740706456;11621.6513504595;12209.69475763113;12232.266064036186;10760.46197690128;11149.554017839195;11252.212345135762;11322.716932076764;12167.878321216675;10814.134869210602;11167.38579378142;11559;11578.478968446609;11586.478608462809;9530.475823829756;9558.522073896416;9702.466364350028;9867.506624668595;9905.108540231413;9261.67584134552;9904.207663387057;10093.14208292274;10102.747431314276;10127.696169114939 11:39:58 INFO - PROCESS | 8809 | __end_tp_report 11:39:58 INFO - PROCESS | 8809 | __start_cc_report 11:39:58 INFO - PROCESS | 8809 | _x_x_mozilla_cycle_collect,1197 11:39:58 INFO - PROCESS | 8809 | __end_cc_report 11:39:58 INFO - PROCESS | 8809 | __startTimestamp1476211198575__endTimestamp 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | ------- Summary: start ------- 11:39:58 INFO - PROCESS | 8809 | Number of tests: 6 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#0] dojo.html Cycles:165 Average:4613.06 Median:4729.60 stddev:474.80 (10.0%) stddev-sans-first:447.13 11:39:58 INFO - PROCESS | 8809 | Values: 2525.7 2560.3 2574.3 2595.8 2605.1 4525.1 4637.4 4716.5 4720.4 4740.1 4613.0 4621.0 4636.7 4671.4 4729.6 4233.6 4302.7 4334.7 4361.5 4362.1 4344.0 4379.3 4396.7 4412.8 4461.6 4200.9 4365.5 4376.9 4402.5 4464.7 4245.2 4265.6 4288.5 4323.2 4330.0 4266.0 4287.0 4299.9 4340.0 4344.8 4657.1 4664.0 4685.1 4696.8 4706.7 4814.6 4869.1 4871.8 4933.2 4995.7 5009.7 5040.9 5052.8 5077.0 5105.7 4686.9 4689.8 4690.2 4695.7 4746.3 4923.0 4945.4 5142.4 5145.7 5204.2 4770.3 4796.0 4869.7 4924.3 5009.7 5012.4 5015.7 5022.2 5027.1 5088.9 4934.1 4957.1 4965.7 4982.3 5047.0 4816.6 4875.5 4879.2 4899.6 4932.0 4293.7 4295.5 4295.9 4296.0 4299.4 3712.9 3719.8 3725.6 3795.1 3813.7 4307.0 4310.4 4311.3 4363.7 4366.1 4981.0 4984.2 4988.7 4992.6 5049.2 4205.2 4253.3 4273.9 4304.1 4315.0 4528.6 4529.8 4529.8 4583.6 4588.8 4630.3 4651.0 4651.9 4657.6 4734.8 4820.3 4830.0 4888.4 4995.4 5008.3 4579.1 4582.1 4595.9 4597.6 4598.2 4856.6 4870.2 4871.6 4883.8 4902.0 5010.5 5012.9 5059.9 5069.7 5073.6 4868.9 4878.0 4879.7 4886.1 4948.1 4737.8 4795.8 4872.6 4877.5 4891.7 4713.5 4736.8 4753.0 4779.7 4784.4 4887.5 4889.9 4897.8 4941.5 4956.5 4773.6 4774.1 4777.9 4833.3 4836.2 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#1] ext.html Cycles:180 Average:48828.94 Median:197539.82 stddev:92764.11 (47.0%) stddev-sans-first:92953.52 11:39:58 INFO - PROCESS | 8809 | Values: 551.5 568.0 574.4 578.9 581.1 27501.6 28134.9 30062.8 30133.2 30160.1 29704.7 37892.0 38792.8 39069.2 42546.8 7617.5 7752.4 7762.1 7764.7 7768.7 7656.4 7751.6 7756.6 7757.6 7759.2 7758.4 7786.6 7787.2 7797.4 7799.9 7723.3 7773.5 7779.0 7784.7 7795.0 7727.3 7738.3 7752.6 7796.3 7798.1 35321.3 35586.0 35606.3 35665.0 35785.5 2840.2 2926.9 2969.3 3077.0 3410.2 27042.2 27393.3 27883.3 28098.2 28150.4 3131.3 3161.0 3210.6 3350.8 3365.5 250478.0 250999.0 250999.0 252376.0 252996.0 49973.5 50219.5 50336.2 50357.7 55210.4 52613.7 58327.4 58330.0 58347.4 58439.4 14903.9 15119.5 15124.7 15140.3 15150.7 11100.3 11307.0 11331.9 11335.8 11419.5 15855.7 16307.6 18361.0 18433.3 18508.8 6805.2 6827.4 7028.9 7086.6 7223.9 777.9 825.9 839.1 966.4 988.4 25529.7 27423.0 27515.7 27962.3 28122.2 869.6 941.6 942.7 962.5 1033.1 13609.4 14549.9 14576.0 14611.7 14734.8 376131.0 376491.0 376613.0 377304.0 378698.0 41588.8 42381.2 47182.5 48120.5 48601.3 1120.9 1160.6 1163.6 1168.9 1177.3 27380.3 27603.4 28340.0 28947.6 28993.0 41107.2 41423.8 41556.8 41562.5 41608.4 318338.0 359287.0 367892.0 368528.0 561137.0 36663.8 37031.2 37190.4 37394.6 37814.0 40032.0 40848.4 41060.4 41156.8 41559.2 35098.3 35126.0 35201.5 35598.3 35792.6 35355.0 35507.6 35662.6 35983.0 36022.6 33631.7 34003.3 34122.5 34410.7 35141.1 29532.9 31484.0 31545.8 31802.2 31821.7 24268.8 24364.3 24382.8 24473.4 24590.5 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#2] jquery.html Cycles:180 Average:22629.40 Median:5025.74 stddev:55983.53 (1113.9%) stddev-sans-first:56115.54 11:39:58 INFO - PROCESS | 8809 | Values: 326.7 338.0 353.9 354.8 376.8 12125.7 16419.3 16617.3 16954.2 17104.4 15960.9 16181.1 16474.0 16665.9 16684.7 3895.8 4880.7 5104.4 5118.7 5170.1 5009.9 5041.6 5041.7 5048.3 5050.5 4833.1 4997.3 5001.2 5001.8 5053.5 4946.4 4982.4 4993.6 4996.2 5007.3 4330.9 4480.8 4516.8 4518.3 4525.1 19840.0 19851.5 19958.8 20036.0 20202.2 1914.1 1922.5 1974.8 2059.7 2303.2 12366.0 12733.5 12960.9 13328.7 13475.7 1642.6 1675.1 1695.7 1706.6 1789.5 65069.0 67053.3 67683.7 67798.3 67889.0 9053.3 9085.1 9371.0 9398.5 9718.4 13333.2 13338.3 13340.1 13350.8 13351.4 7094.0 7137.4 7274.4 7337.1 7356.0 6841.9 6927.4 6969.0 7064.6 7145.0 5718.5 5799.4 5803.9 5929.7 6012.5 1572.2 1612.0 1675.1 1724.9 1761.4 682.2 861.2 866.9 890.3 907.5 16109.6 16433.7 16892.2 17228.1 17331.3 840.9 854.9 861.2 869.8 883.7 9334.3 9751.1 9932.2 9957.1 10077.7 298859.0 299630.0 301323.0 382237.0 383097.0 80346.6 82895.6 83378.6 84727.2 87034.0 866.7 892.0 903.4 908.9 910.4 14754.7 15029.8 15743.6 15787.5 16070.0 34812.7 35477.5 35772.5 35888.6 36974.4 45418.5 47067.0 51570.0 51916.5 52801.9 7110.7 7271.9 7345.7 7540.8 7550.2 10579.6 10618.6 10788.3 10819.7 11113.7 8546.8 8746.4 9405.3 9489.8 9747.0 9346.0 9515.4 9521.9 9634.2 10051.7 8920.5 9202.7 9240.6 9485.1 9597.1 7101.6 7360.8 7422.3 7507.5 7545.3 7723.4 8965.8 8997.1 9501.0 9806.0 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#3] mootools.html Cycles:180 Average:4915.78 Median:5028.67 stddev:2727.92 (54.2%) stddev-sans-first:2722.29 11:39:58 INFO - PROCESS | 8809 | Values: 1333.5 1371.8 1412.3 1648.3 1657.3 6507.6 6737.1 7121.1 7727.0 7729.0 7123.0 7421.7 7436.3 7609.5 7646.3 2123.9 2146.6 2150.1 2151.0 2153.3 1766.8 1839.3 2104.1 2131.8 2147.8 2042.1 2101.8 2109.1 2116.4 2121.1 2083.2 2090.0 2095.9 2111.6 2114.8 2082.2 2100.3 2101.0 2101.3 2106.3 7543.7 7545.5 7599.4 7650.8 7651.1 4437.4 4576.5 4577.5 4579.2 4582.2 2625.7 2780.5 2821.7 2838.4 2848.5 864.8 865.9 871.1 884.9 887.8 10132.7 10142.4 10160.8 10160.8 10164.1 3786.1 3881.9 4049.3 4086.2 4091.1 8759.3 8761.3 8789.3 8789.8 8792.2 4522.3 4527.1 4530.8 4534.1 4537.5 4033.5 4112.9 4127.5 4128.8 4130.9 3547.9 3579.6 3646.7 3661.4 3700.2 1072.3 1113.9 1175.6 1181.4 1195.8 659.0 722.3 722.3 746.7 817.9 4770.8 4989.6 5037.6 5057.0 5217.7 810.7 832.2 834.5 867.7 897.2 3240.3 3346.5 3443.1 3458.9 3508.8 8944.9 9239.4 9241.4 9247.6 9252.3 8451.7 9099.5 9177.7 9196.3 9232.1 6729.4 7076.7 7077.9 7083.4 7086.7 4826.5 4997.2 5001.8 5019.7 5157.5 7954.6 8077.5 8081.0 8199.5 8221.6 8165.2 8408.2 8466.9 8472.3 8475.6 6637.3 6761.2 6762.8 6765.0 6765.5 7172.9 7180.5 7192.6 7248.0 7285.3 5393.8 6479.4 6518.9 6525.8 6618.2 6486.4 6592.3 6619.5 6635.0 6643.8 6156.8 6271.2 6273.3 6281.5 6283.9 4184.1 4185.2 4237.9 4244.4 4365.1 4158.5 4177.1 4207.4 4272.2 4299.8 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#4] prototype.html Cycles:180 Average:4250.63 Median:4837.54 stddev:1235.59 (25.5%) stddev-sans-first:1202.82 11:39:58 INFO - PROCESS | 8809 | Values: 292.8 293.3 304.7 306.5 308.5 4788.9 4885.6 4925.5 4942.8 4970.9 4697.9 4804.7 4807.0 4819.6 4885.6 3874.8 3880.5 3889.8 3892.8 3898.2 3645.3 3887.8 3905.9 3919.9 3921.6 3578.9 3800.7 3818.8 3831.9 3865.9 3853.3 3862.2 3862.8 3863.7 3866.8 3423.1 3426.5 3434.3 3436.4 3437.1 4561.2 4759.5 4765.0 4801.7 4818.9 4321.3 4344.9 4347.2 4347.7 4351.8 5101.2 5115.0 5141.6 5177.3 5182.9 3420.0 3611.8 3616.4 3621.7 3657.5 5303.9 5313.7 5318.8 5328.6 5342.5 3728.4 3731.2 3733.0 3735.5 3743.9 3751.3 3753.5 3763.2 3763.6 3766.2 4212.2 4260.5 4277.1 4301.0 4311.6 5030.4 5048.1 5049.4 5058.9 5084.2 1199.1 1239.7 1284.1 1288.6 1303.1 849.3 877.2 877.6 889.6 892.7 4471.3 4485.9 4495.6 4501.8 4514.9 5239.2 5254.2 5258.6 5264.7 5264.7 4392.0 4471.2 4488.2 4492.7 4517.0 2757.4 2762.3 2775.4 2777.6 2780.1 4849.3 4881.1 4881.2 4885.7 4888.2 5139.4 5384.9 5391.8 5413.6 5426.9 4948.6 4964.1 4967.5 4972.0 4984.2 5032.6 5303.4 5310.9 5324.8 5327.3 5206.0 5219.9 5219.9 5220.1 5243.9 4927.4 4972.2 5002.3 5057.6 5059.3 3555.3 3751.9 3763.9 3772.7 3775.9 5218.3 5235.5 5237.5 5299.8 5312.9 5078.7 5082.9 5113.2 5147.4 5175.4 4917.6 5079.8 5146.9 5149.6 5173.2 4825.8 4973.6 5008.3 5045.3 5048.6 5009.7 5170.9 5191.7 5212.8 5215.5 5070.2 5073.0 5078.5 5106.3 5132.8 11:39:58 INFO - PROCESS | 8809 | 11:39:58 INFO - PROCESS | 8809 | [#5] yui.html Cycles:180 Average:16501.41 Median:480.24 stddev:23413.07 (4875.3%) stddev-sans-first:23448.30 11:39:58 INFO - PROCESS | 8809 | Values: 600.3 605.2 663.9 673.1 675.2 12494.6 12926.7 13375.7 13645.1 13663.5 13081.3 13295.9 13350.4 13353.2 13355.2 602.8 623.9 737.4 757.2 760.3 726.4 751.8 753.3 754.7 755.0 803.2 803.5 805.0 805.5 806.0 628.4 648.1 795.0 795.0 795.9 479.8 480.2 480.3 561.8 578.4 12606.0 12637.7 12643.3 12653.4 12667.6 11729.4 11753.2 11890.0 12042.1 12778.4 11173.7 11223.9 11332.5 11452.3 11534.4 3930.7 3985.8 4064.9 4125.7 4150.7 59178.7 62074.7 62330.7 62358.0 63442.7 9231.9 9271.5 9364.6 9437.1 9637.3 17732.8 17764.9 17807.2 17826.4 17844.0 6125.6 6131.4 6251.0 6261.1 6294.9 3347.1 3458.4 3502.9 3512.5 3535.0 2713.8 2773.6 2809.2 2819.3 3045.5 544.0 544.3 552.0 553.8 562.9 531.0 545.2 593.6 602.9 614.1 8108.8 8217.5 8253.3 8380.0 8674.0 491.0 549.3 570.9 607.8 608.6 3869.1 3956.8 3986.3 4156.2 4175.1 53680.7 60887.7 98509.0 100166.5 102178.5 83675.0 83813.6 84102.6 85312.0 85372.6 72827.6 74513.3 75981.2 75989.2 77032.6 7781.8 7905.4 7946.4 8011.6 8244.1 29128.1 35884.6 37583.4 40293.4 42152.8 34338.3 36397.6 36999.6 47530.5 50716.5 11488.1 11532.5 11642.0 11893.9 11906.8 12683.2 12774.6 12836.2 13245.6 13459.1 11299.5 11303.7 11621.7 12209.7 12232.3 10760.5 11149.6 11252.2 11322.7 12167.9 10814.1 11167.4 11559.0 11578.5 11586.5 9530.5 9558.5 9702.5 9867.5 9905.1 9261.7 9904.2 10093.1 10102.7 10127.7 11:39:58 INFO - PROCESS | 8809 | -------- Summary: end -------- 11:39:58 INFO - PROCESS | 8809 | 11:39:59 INFO - TEST-INFO | 8809: exit 0 11:39:59 INFO - TEST-OK | dromaeo_css | took 1121612ms 11:39:59 INFO - TEST-START | kraken 11:39:59 INFO - operating with platform_type : linux_ 11:39:59 INFO - Initialising browser for kraken test... 11:39:59 INFO - TEST-INFO | started process 9119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtqHiw/profile http://localhost:51136/getInfo.html) 11:40:03 INFO - PROCESS | 9119 | __metrics Screen width/height:1600/1200 11:40:03 INFO - PROCESS | 9119 | colorDepth:24 11:40:03 INFO - PROCESS | 9119 | Browser inner width/height: 1024/697 11:40:03 INFO - PROCESS | 9119 | __metrics 11:40:04 INFO - PROCESS | 9119 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:40:04 INFO - PROCESS | 9119 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:04 INFO - PROCESS | 9119 | console.error: PushService: 11:40:04 INFO - PROCESS | 9119 | stateChangeProcessEnqueue: Error transitioning state 11:40:04 INFO - PROCESS | 9119 | UnknownError 11:40:05 INFO - TEST-INFO | 9119: exit 0 11:40:05 INFO - Browser initialized. 11:40:05 INFO - Running cycle 1/1 for kraken test... 11:40:05 INFO - TEST-INFO | started process 9200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOtqHiw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:17 INFO - PROCESS | 9200 | RSS: Main: 174362624 11:40:17 INFO - PROCESS | 9200 | 11:40:20 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51136/tests/kraken/driver.html?testName=audio-beat-detection) 11:40:21 INFO - PROCESS | 9200 | RSS: Main: 233431040 11:40:21 INFO - PROCESS | 9200 | 11:40:24 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51136/tests/kraken/driver.html?testName=audio-dft) 11:40:25 INFO - PROCESS | 9200 | RSS: Main: 218488832 11:40:25 INFO - PROCESS | 9200 | 11:40:28 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51136/tests/kraken/driver.html?testName=audio-fft) 11:40:28 INFO - PROCESS | 9200 | RSS: Main: 300015616 11:40:28 INFO - PROCESS | 9200 | 11:40:31 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51136/tests/kraken/driver.html?testName=audio-oscillator) 11:40:31 INFO - PROCESS | 9200 | RSS: Main: 208834560 11:40:31 INFO - PROCESS | 9200 | 11:40:33 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51136/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:40:34 INFO - PROCESS | 9200 | RSS: Main: 214200320 11:40:34 INFO - PROCESS | 9200 | 11:40:37 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51136/tests/kraken/driver.html?testName=imaging-darkroom) 11:40:38 INFO - PROCESS | 9200 | RSS: Main: 250228736 11:40:38 INFO - PROCESS | 9200 | 11:40:41 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51136/tests/kraken/driver.html?testName=imaging-desaturate) 11:40:42 INFO - PROCESS | 9200 | RSS: Main: 249495552 11:40:42 INFO - PROCESS | 9200 | 11:40:45 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51136/tests/kraken/driver.html?testName=json-parse-financial) 11:40:45 INFO - PROCESS | 9200 | RSS: Main: 248524800 11:40:45 INFO - PROCESS | 9200 | 11:40:47 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51136/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:48 INFO - PROCESS | 9200 | RSS: Main: 211394560 11:40:48 INFO - PROCESS | 9200 | 11:40:50 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:50 INFO - PROCESS | 9200 | RSS: Main: 218869760 11:40:50 INFO - PROCESS | 9200 | 11:40:52 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:53 INFO - PROCESS | 9200 | RSS: Main: 228065280 11:40:53 INFO - PROCESS | 9200 | 11:40:56 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:57 INFO - PROCESS | 9200 | RSS: Main: 236830720 11:40:57 INFO - PROCESS | 9200 | 11:41:00 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:41:00 INFO - PROCESS | 9200 | RSS: Main: 233218048 11:41:00 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | Cycle 1(1): loaded http://localhost:51136/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51136/tests/kraken/driver.html?testName=ai-astar) 11:41:02 INFO - PROCESS | 9200 | RSS: Main: 284450816 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | __start_tp_report 11:41:02 INFO - PROCESS | 9200 | _x_x_mozilla_page_load 11:41:02 INFO - PROCESS | 9200 | _x_x_mozilla_page_load_details 11:41:02 INFO - PROCESS | 9200 | |i|pagename|runs| 11:41:02 INFO - PROCESS | 9200 | |0;ai-astar;111;114;115;114;113;116;116;115;114;116 11:41:02 INFO - PROCESS | 9200 | |1;audio-beat-detection;152;133;141;176;127;126;132;125;158;125 11:41:02 INFO - PROCESS | 9200 | |2;audio-dft;161;163;162;160;160;161;163;161;162;159 11:41:02 INFO - PROCESS | 9200 | |3;audio-fft;77;77;78;115;77;78;77;77;117;77 11:41:02 INFO - PROCESS | 9200 | |4;audio-oscillator;84;83;130;83;83;83;112;82;84;122 11:41:02 INFO - PROCESS | 9200 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 11:41:02 INFO - PROCESS | 9200 | |6;imaging-darkroom;147;147;147;146;147;147;146;146;146;147 11:41:02 INFO - PROCESS | 9200 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;94;95 11:41:02 INFO - PROCESS | 9200 | |8;json-parse-financial;63;64;64;64;68;64;65;65;65;67 11:41:02 INFO - PROCESS | 9200 | |9;json-stringify-tinderbox;66;66;65;65;67;66;65;66;65;66 11:41:02 INFO - PROCESS | 9200 | |10;stanford-crypto-aes;83;83;86;85;89;85;81;82;82;82 11:41:02 INFO - PROCESS | 9200 | |11;stanford-crypto-ccm;154;137;136;136;137;137;136;138;185;146 11:41:02 INFO - PROCESS | 9200 | |12;stanford-crypto-pbkdf2;183;176;175;174;174;175;173;172;174;171 11:41:02 INFO - PROCESS | 9200 | |13;stanford-crypto-sha256-iterative;69;70;70;69;69;69;70;69;69;69 11:41:02 INFO - PROCESS | 9200 | __end_tp_report 11:41:02 INFO - PROCESS | 9200 | __start_cc_report 11:41:02 INFO - PROCESS | 9200 | _x_x_mozilla_cycle_collect,1967 11:41:02 INFO - PROCESS | 9200 | __end_cc_report 11:41:02 INFO - PROCESS | 9200 | __startTimestamp1476211262806__endTimestamp 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | ------- Summary: start ------- 11:41:02 INFO - PROCESS | 9200 | Number of tests: 14 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:1.58 (1.4%) stddev-sans-first:1.09 11:41:02 INFO - PROCESS | 9200 | Values: 111.0 114.0 115.0 114.0 113.0 116.0 116.0 115.0 114.0 116.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:137.00 stddev:17.29 (12.6%) stddev-sans-first:17.74 11:41:02 INFO - PROCESS | 9200 | Values: 152.0 133.0 141.0 176.0 127.0 126.0 132.0 125.0 158.0 125.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.39 11:41:02 INFO - PROCESS | 9200 | Values: 161.0 163.0 162.0 160.0 160.0 161.0 163.0 161.0 162.0 159.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#3] audio-fft Cycles:10 Average:85.00 Median:77.00 stddev:16.35 (21.2%) stddev-sans-first:17.08 11:41:02 INFO - PROCESS | 9200 | Values: 77.0 77.0 78.0 115.0 77.0 78.0 77.0 77.0 117.0 77.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:83.00 stddev:18.94 (22.8%) stddev-sans-first:19.70 11:41:02 INFO - PROCESS | 9200 | Values: 84.0 83.0 130.0 83.0 83.0 83.0 112.0 82.0 84.0 122.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 11:41:02 INFO - PROCESS | 9200 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:41:02 INFO - PROCESS | 9200 | Values: 147.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 146.0 147.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:41:02 INFO - PROCESS | 9200 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.45 11:41:02 INFO - PROCESS | 9200 | Values: 63.0 64.0 64.0 64.0 68.0 64.0 65.0 65.0 65.0 67.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 11:41:02 INFO - PROCESS | 9200 | Values: 66.0 66.0 65.0 65.0 67.0 66.0 65.0 66.0 65.0 66.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:2.44 (2.9%) stddev-sans-first:2.57 11:41:02 INFO - PROCESS | 9200 | Values: 83.0 83.0 86.0 85.0 89.0 85.0 81.0 82.0 82.0 82.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:137.50 stddev:15.49 (11.3%) stddev-sans-first:16.02 11:41:02 INFO - PROCESS | 9200 | Values: 154.0 137.0 136.0 136.0 137.0 137.0 136.0 138.0 185.0 146.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:174.50 stddev:3.27 (1.9%) stddev-sans-first:1.56 11:41:02 INFO - PROCESS | 9200 | Values: 183.0 176.0 175.0 174.0 174.0 175.0 173.0 172.0 174.0 171.0 11:41:02 INFO - PROCESS | 9200 | 11:41:02 INFO - PROCESS | 9200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:41:02 INFO - PROCESS | 9200 | Values: 69.0 70.0 70.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 11:41:02 INFO - PROCESS | 9200 | -------- Summary: end -------- 11:41:02 INFO - PROCESS | 9200 | 11:41:04 INFO - TEST-INFO | 9200: exit 0 11:41:04 INFO - TEST-OK | kraken | took 64684ms 11:41:04 INFO - SUITE-END | took 1186s 11:41:04 INFO - Completed test suite (00:19:46) 11:41:04 INFO - javascript benchmark 11:41:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2525.7095434025086, 2560.3471114865706, 2574.253466494716, 2595.8182927195103, 2605.0751983046016, 4525.140223357568, 4637.443506779183, 4716.528347165282, 4720.409948756405, 4740.146773580754, 4612.953870461294, 4620.976895115528, 4636.721796692193, 4671.439427268732, 4729.597984171341, 4233.618974292313, 4302.677299202556, 4334.718243314191, 4361.476622805268, 4362.0621566363225, 4344.02259491615, 4379.299312110063, 4396.670249731283, 4412.75729834859, 4461.598456138947, 4200.873973780792, 4365.476142862845, 4376.89057773555, 4402.537733537981, 4464.6651501137385, 4245.193413251503, 4265.55211702773, 4288.52826189119, 4323.2218200723855, 4329.982454123278, 4266.040140968288, 4287.0, 4299.892502687427, 4340.045190058182, 4344.761038142901, 4657.068586282757, 4664.0, 4685.086408150412, 4696.765161741933, 4706.717596944194, 4814.566688997972, 4869.050535145648, 4871.805127794884, 4933.1860243059855, 4995.700257984533, 5009.674371165863, 5040.899182016376, 5052.797888084509, 5077.035363280965, 5105.744712764347, 4686.906261874743, 4689.8358557450665, 4690.202665546865, 4695.741734204583, 4746.335513028179, 4922.950770492321, 4945.431275403303, 5142.434332223453, 5145.742712864342, 5204.1673332266655, 4770.284457331359, 4796.0, 4869.70781753096, 4924.3352147460355, 5009.674371165863, 5012.423571289275, 5015.724135172601, 5022.246663000579, 5027.069992051483, 5088.92366614501, 4934.087193869145, 4957.107720610253, 4965.652404331734, 4982.327385802942, 5046.990601879639, 4816.566509014206, 4875.512448755097, 4879.194932836042, 4899.632527560448, 4932.013597280558, 4293.677974151951, 4295.52749197588, 4295.935560966588, 4296.033392486665, 4299.419578356944, 3712.9071773205346, 3719.8326075326677, 3725.5529336479794, 3795.1271207622403, 3813.7139714520968, 4307.0, 4310.396544483775, 4311.267084595626, 4363.650907927358, 4366.14860102277, 4981.0, 4984.152694041949, 4988.72562009093, 4992.625553083533, 5049.192129259301, 4205.201011807747, 4253.340732186516, 4273.850415235452, 4304.139172165579, 4314.956850431518, 4528.637708983273, 4529.750863702462, 4529.750863702462, 4583.633309335245, 4588.7935042923145, 4630.32860235264, 4650.953490465052, 4651.898734177295, 4657.5575320344515, 4734.786934588021, 4820.325154478306, 4830.0, 4888.388951380935, 4995.375578052744, 5008.323876276656, 4579.06129243511, 4582.1293954148605, 4595.885102872455, 4597.632189424905, 4598.172328980816, 4856.562909338177, 4870.220764677776, 4871.610271178368, 4883.8290659826735, 4901.975490122669, 5010.549050585465, 5012.949870501394, 5059.87350316245, 5069.7465126744255, 5073.568746656576, 4868.853934381974, 4877.975610121926, 4879.658423910434, 4886.071646387317, 4948.084604348207, 4737.8341758038305, 4795.832145875017, 4872.585830204473, 4877.463479017376, 4891.706497610155, 4713.505081966344, 4736.763161841825, 4753.049390122059, 4779.737114458738, 4784.425868895755, 4887.511248875084, 4889.877753056202, 4897.804087836446, 4941.530554597308, 4956.504349565014, 4773.570378665937, 4774.116788394158, 4777.904441911072, 4833.323334733211, 4836.226203807374], "value": 4582.815935992208, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5008916930178, 568.0230004392446, 574.4169667787199, 578.866860622057, 581.1254062635733, 27501.587476187873, 28134.859325703368, 30062.849685751597, 30133.246668833235, 30160.09519714409, 29704.702952970463, 37892.0, 38792.80603596985, 39069.21861562767, 42546.7872660637, 7617.46677732559, 7752.379809615217, 7762.146163921964, 7764.689412423496, 7768.650410731502, 7656.3874890008665, 7751.573663448508, 7756.612169391536, 7757.612119394008, 7759.224077592224, 7758.418118641124, 7786.571738554378, 7787.182345853689, 7797.415193860455, 7799.883001754978, 7723.2662897024975, 7773.494722843054, 7778.961105194495, 7784.688612455467, 7794.961025194894, 7727.343175830061, 7738.303552680286, 7752.573608451533, 7796.259355361231, 7798.103218129931, 35321.29357412863, 35586.0, 35606.287874242626, 35665.0, 35785.46321805149, 2840.247334456371, 2926.897558585439, 2969.317057076863, 3076.969230307691, 3410.198603328216, 27042.188734338, 27393.31516712078, 27883.302917427023, 28098.157055288375, 28150.43699126006, 3131.3424180922034, 3160.98419507901, 3210.598675165604, 3350.7654464187517, 3365.528825964367, 250478.0, 250999.0, 250999.0, 252376.0, 252996.0, 49973.50026499761, 50219.49780502221, 50336.24495632568, 50357.74821125871, 55210.447895521334, 52613.7369313151, 58327.4167258322, 58330.0, 58347.41652583505, 58439.415605844246, 14903.850961490463, 15119.470818521298, 15124.697506049817, 15140.318685659171, 15150.696986060217, 11100.278481898651, 11307.038901693284, 11331.886681133248, 11335.773284534263, 11419.543218271176, 15855.682886342209, 16307.59231019234, 18361.0, 18433.26266949334, 18508.81491185071, 6805.183377994672, 6827.351401616838, 7028.92971070293, 7086.574805511686, 7223.916412538161, 777.941654375924, 825.8554752918216, 839.131498898637, 966.4056605187759, 988.4168340679034, 25529.744702552736, 27423.04019359313, 27515.724842751715, 27962.300942476195, 28122.156335309974, 869.5652173913044, 941.6280569175275, 942.7360339105062, 962.5139304651107, 1033.121846430528, 13609.387577559033, 14549.92725036368, 14575.956752874989, 14611.707765844623, 14734.778978315333, 376131.0, 376491.0, 376613.0, 377304.0, 378698.0, 41588.79205603953, 42381.15237695229, 47182.5281747185, 48120.51879481161, 48601.27098093531, 1120.882307357732, 1160.5589875847124, 1163.552032467506, 1168.9123315751183, 1177.2628638415547, 27380.315492112855, 27603.44793104167, 28340.0, 28947.56578651364, 28993.0, 41107.177856443304, 41423.7928810354, 41556.792216038724, 41562.50624962512, 41608.375874362515, 318338.0, 359287.0, 367892.0, 368528.0, 561137.0, 36663.816680916425, 37031.2226583002, 37190.44214336841, 37394.62605373911, 37814.0, 40031.99920002023, 40848.38727419032, 41060.38409423801, 41156.79421602873, 41559.1688166241, 35098.29803403969, 35126.0, 35201.47197791984, 35598.28803423865, 35792.64207357893, 35355.0, 35507.64492355043, 35662.64337356593, 35983.0, 36022.63977360193, 33631.66368336285, 34003.319933601684, 34122.48816267708, 34410.655893440744, 35141.12147196341, 29532.852335738186, 31484.0, 31545.8422707885, 31802.204944876565, 31821.681783181873, 24268.75731242665, 24364.26907192787, 24382.75617243805, 24473.38816529601, 24590.508189835746], "value": 17340.19026984127, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.72228605685154, 338.0332249765671, 353.9150603855075, 354.75521889895964, 376.78711527986684, 12125.696857578565, 16419.34322627095, 16617.252223649935, 16954.152292385363, 17104.401345952894, 15960.920195399036, 16181.110038947852, 16474.0, 16665.91667041666, 16684.749728754046, 3895.7857317847506, 4880.707157570549, 5104.438511763703, 5118.718470484122, 5170.146925757245, 5009.899802003958, 5041.571466425358, 5041.6722913010535, 5048.318477005612, 5050.494950504957, 4833.105875413043, 4997.250412438145, 5001.249812528132, 5001.8249361272365, 5053.494650534935, 4946.40643122824, 4982.427020892607, 4993.575546078588, 4996.225585034307, 5007.2989781430815, 4330.870073897788, 4480.775961201927, 4516.751578663172, 4518.299663552155, 4525.072360166191, 19840.0, 19851.50371240716, 19958.80041199584, 20036.0, 20202.191912323637, 1914.1099388784282, 1922.480930148866, 1974.8025197480138, 2059.6910463430604, 2303.1823702585507, 12366.0, 12733.490660373574, 12960.870391296061, 13328.733425331438, 13475.663108422368, 1642.5729310379388, 1675.1205617051023, 1695.7371607400873, 1706.6416052628963, 1789.5168304557826, 65069.0, 67053.32946670569, 67683.66158169227, 67798.32201678019, 67889.0, 9053.321000924958, 9085.091490850862, 9370.953145234367, 9398.48308343034, 9718.368306060083, 13333.200007999358, 13338.333083345988, 13340.132891362224, 13350.799738003938, 13351.399187036606, 7094.0, 7137.393321567621, 7274.418046556263, 7337.119545654449, 7356.0, 6841.931580684229, 6927.411170050501, 6969.0, 7064.646767661597, 7145.0, 5718.512447085448, 5799.39106393831, 5803.8549036274435, 5929.703514824241, 6012.534860707089, 1572.2060359518598, 1611.9597010074608, 1675.1289329548567, 1724.9310027599006, 1761.4275360507886, 682.2461180395691, 861.1646702698373, 866.9176428239307, 890.3189060368823, 907.5190149220923, 16109.597260068593, 16433.685305175557, 16892.239849206817, 17228.138593070296, 17331.30674772995, 840.9243168114776, 854.9401541892132, 861.173273657296, 869.7738587967048, 883.7172104926491, 9334.253259739204, 9751.122398984126, 9932.205423566098, 9957.125741388087, 10077.69766906994, 298859.0, 299630.0, 301323.0, 382237.0, 383097.0, 80346.59826700829, 82895.585522072, 83378.58310708408, 84727.15272847316, 87034.0, 866.7226487523932, 891.9937639373969, 903.4488961733338, 908.9000209976897, 910.4127837544879, 14754.704905902037, 15029.774553381927, 15743.606409839387, 15787.526374208792, 16069.955452895525, 34812.65187348094, 35477.46783798194, 35772.4634130483, 35888.64111358853, 36974.44538331981, 45418.54581454143, 47067.0, 51570.0, 51916.48083519116, 52801.94396112133, 7110.680019399243, 7271.8909216360735, 7345.706171753283, 7540.8491830164185, 7550.2072282411755, 10579.576816927545, 10618.575256989943, 10788.29876058085, 10819.67540973772, 11113.666590002313, 8546.829063418822, 8746.38775285724, 9405.341626086109, 9489.762755931157, 9747.0, 9346.0, 9515.429074255568, 9521.904780952102, 9634.181094607036, 10051.748706282402, 8920.464772113693, 9202.677906273248, 9240.630374784932, 9485.098915603006, 9597.136257736836, 7101.609411482212, 7360.822268437024, 7422.294881986203, 7507.474476786572, 7545.320921117126, 7723.382129429745, 8965.820683586162, 8997.145271199226, 9501.049895010443, 9806.0], "value": 8001.532681503557, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.513267657305, 1371.7805151175814, 1412.3150272118028, 1648.3159488812144, 1657.328781843353, 6507.6420796856155, 6737.124173857392, 7121.145462544496, 7726.961365193173, 7728.96135519323, 7122.96438517808, 7421.703131874719, 7436.293552112541, 7609.467337286392, 7646.311831935125, 2123.915043398266, 2146.6028784674886, 2150.118451434912, 2151.0, 2153.3001774423374, 1766.8321509456582, 1839.301065595072, 2104.084723145437, 2131.7868213178635, 2147.76374598794, 2042.1320938601036, 2101.8003289687454, 2109.103630956845, 2116.4285642876416, 2121.098533123424, 2083.1771450277206, 2090.0385822521657, 2095.8847263400507, 2111.5852378906093, 2114.7779483154277, 2082.2191678120703, 2100.327895073577, 2101.0335245786955, 2101.2645574049116, 2106.273335699181, 7543.69825206991, 7545.547267163988, 7599.35405490534, 7650.770476885702, 7651.081870175559, 4437.356583295404, 4576.473705523874, 4577.519360467137, 4579.244424669925, 4582.175208462475, 2625.671791026122, 2780.457810726909, 2821.746042856132, 2838.403935173616, 2848.51575232211, 864.8183881384854, 865.9393842431033, 871.1488087813397, 884.9115088491163, 887.8268737596171, 10132.746681332952, 10142.391456512632, 10160.847587286196, 10160.847587286196, 10164.085232329053, 3786.1481166737262, 3881.8641347553266, 4049.2913740095364, 4086.244044851712, 4091.0590564170407, 8759.34304927133, 8761.34289928258, 8789.296856251613, 8789.824203516022, 8792.208701216921, 4522.276435770261, 4527.139843429738, 4530.841420550265, 4534.115847409789, 4537.455505339314, 4033.495813023372, 4112.876613701594, 4127.484064491939, 4128.793560321972, 4130.896727581774, 3547.8758243461357, 3579.6420357964516, 3646.690031347365, 3661.377565813818, 3700.16746232101, 1072.3351522056219, 1113.8663360396804, 1175.5767923547517, 1181.4211036592008, 1195.7967145585271, 658.9538732288694, 722.2596838240845, 722.3498851034111, 746.7050515046526, 817.9427440079256, 4770.785314660849, 4989.625778066659, 5037.622178336639, 5056.974715126475, 5217.686938783685, 810.6757297081097, 832.2010869565164, 834.486790623762, 867.7353407210735, 897.1566727276339, 3240.3357311751033, 3346.498025296225, 3443.104792753852, 3458.9308213835584, 3508.824558772102, 8944.8658270126, 9239.39943903644, 9241.399309044891, 9247.630094796268, 9252.259819214447, 8451.704190353308, 9099.545022748836, 9177.724668259963, 9196.264298856075, 9232.076792320715, 6729.4279986200745, 7076.681549330293, 7077.893831592531, 7083.433325333961, 7086.681099350439, 4826.493218212037, 4997.175466048061, 5001.799928002984, 5019.7239151847, 5157.535821776059, 7954.602269886367, 8077.474964127313, 8081.0, 8199.549024803693, 8221.630026648696, 8165.224303691378, 8408.159184081544, 8466.91533084686, 8472.322214222724, 8475.618597163018, 6637.2699003108655, 6761.222459417033, 6762.763303284361, 6765.0, 6765.492588055817, 7172.856542869009, 7180.533265337736, 7192.604406757469, 7247.9637601813765, 7285.344319011315, 5393.8112166074, 6479.384458476437, 6518.934810651833, 6525.771597994048, 6618.172728408949, 6486.3513648636645, 6592.307807680317, 6619.470442364695, 6634.966825165843, 6643.800685979429, 6156.78451254204, 6271.216097987752, 6273.341299163704, 6281.497480201664, 6283.905741413974, 4184.142250838631, 4185.246655602021, 4237.87286381409, 4244.3633454982, 4365.061511774984, 4158.531531036798, 4177.12280421115, 4207.389928460418, 4272.166927449118, 4299.785010749512], "value": 3965.7599442970577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.8155262184823, 293.2873118322476, 304.7455374762074, 306.50040434092426, 308.5156304601776, 4788.880277993043, 4885.609151267899, 4925.507449255073, 4942.777575009129, 4970.887372866531, 4697.929531057029, 4804.711717296965, 4807.0, 4819.638527110464, 4885.633577481694, 3874.8256328465145, 3880.5343358796986, 3889.844406223762, 3892.82482288297, 3898.200868821899, 3645.3073915956015, 3887.844486220562, 3905.902352441183, 3919.8628048018327, 3921.627430399366, 3578.870572009663, 3800.6769424598942, 3818.8281527331337, 3831.865884694036, 3865.942010869839, 3853.2871418787613, 3862.1696335288048, 3862.80685965702, 3863.652271295569, 3866.839948015598, 3423.1442139465134, 3426.509468381237, 3434.347473979961, 3436.415809312398, 3437.071990562534, 4561.2245918193985, 4759.452662943737, 4765.0, 4801.68789028712, 4818.927716084261, 4321.308590625485, 4344.89137771555, 4347.239233134221, 4347.69566130371, 4351.8476853309985, 5101.183810590288, 5115.0, 5141.632230888737, 5177.291493807034, 5182.896342073137, 3420.0, 3611.837467313951, 3616.4032934565766, 3621.692156166729, 3657.5428071491065, 5303.946960530384, 5313.681179129226, 5318.813841515567, 5328.6269961102735, 5342.492463215988, 3728.366177749789, 3731.1604888900324, 3732.9813350933073, 3735.533058367704, 3743.9251214975548, 3751.2872554214614, 3753.530808648919, 3763.209725957525, 3763.6048214937587, 3766.1902690921033, 4212.241796476603, 4260.531341552427, 4277.144571085795, 4300.978495107504, 4311.590398912098, 5030.4215015272985, 5048.0913435581215, 5049.358958338481, 5058.898822023539, 5084.237364395371, 1199.1366216324407, 1239.7148655809035, 1284.0867108009186, 1288.6134159752037, 1303.1138825598684, 849.3375167369462, 877.2105105405059, 877.6489404238229, 889.644142343055, 892.6786356911507, 4471.323253779832, 4485.887852803706, 4495.550444955544, 4501.842435514741, 4514.88712782183, 5239.161734122522, 5254.159334506537, 5258.579313654898, 5264.736763161826, 5264.736763161826, 4391.978040109843, 4471.217536931024, 4488.236999710057, 4492.7311707588115, 4517.006258623098, 2757.3658058646624, 2762.2597763408926, 2775.4310366374843, 2777.5694767311097, 2780.138157171283, 4849.2968519565175, 4881.145799485076, 4881.243407271879, 4885.706857588485, 4888.169011268093, 5139.434662187156, 5384.9461505385225, 5391.81128660495, 5413.593980451482, 5426.945730542723, 4948.579370753454, 4964.081644895634, 4967.503249675004, 4971.975140124348, 4984.22744474607, 5032.6225533084435, 5303.390110137384, 5310.920336195038, 5324.8136315228785, 5327.334083239595, 5205.973970130125, 5219.929914367622, 5219.947800521946, 5220.120756527571, 5243.921341179962, 4927.384076990376, 4972.229304457815, 5002.274670172732, 5057.6459647824295, 5059.3169922061525, 3555.306715190513, 3751.887443376594, 3763.9059023524633, 3772.6981841453166, 3775.867844625425, 5218.347706536683, 5235.476452354734, 5237.502437268454, 5299.814506492408, 5312.946870531246, 5078.695278283315, 5082.932584157368, 5113.15632920564, 5147.356580427447, 5175.353080864892, 4917.598484432063, 5079.822206222764, 5146.897062058663, 5149.562287205629, 5173.1893837156695, 4825.782839772149, 4973.577245934136, 5008.3238762768015, 5045.293658887832, 5048.646594738333, 5009.699418034929, 5170.896582068262, 5191.662541934762, 5212.765425555784, 5215.478452154906, 5070.163423035306, 5073.0, 5078.4921507850395, 5106.310648062613, 5132.79468821243], "value": 3856.1995271792066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.2916558461015, 605.2192671453828, 663.8738639658463, 673.135021497376, 675.2032601530195, 12494.562690305842, 12926.741465170691, 13375.665608359795, 13645.113067650607, 13663.453461861514, 13081.28052957087, 13295.867041329584, 13350.399232034557, 13353.198808071498, 13355.198688078723, 602.8191542537244, 623.8814625221216, 737.4248086492518, 757.1822431773671, 760.3423039071191, 726.3898325406657, 751.8345963887936, 753.2542782645169, 754.7358424551418, 755.0260164387932, 803.2008151888879, 803.4817542684965, 804.9919500805005, 805.4603415711488, 805.9798505037392, 628.3936001758325, 648.0894343447417, 794.972175973841, 795.0141824138057, 795.9442839001272, 479.82966047053145, 480.20046622373707, 480.27718283982733, 561.7668667502982, 578.3580225949192, 12606.0, 12637.684057898534, 12643.304618245993, 12653.430595623218, 12667.61997140078, 11729.354885481294, 11753.236039657395, 11890.0, 12042.096842736742, 12778.424970876333, 11173.72065698356, 11223.913151241743, 11332.490037948312, 11452.255603385753, 11534.423278836024, 3930.7051971102283, 3985.7807820569856, 4064.8577299794365, 4125.66994640431, 4150.667946564267, 59178.70410647919, 62074.689626552026, 62330.68834655843, 62358.0, 63442.68278658577, 9231.90768092324, 9271.490068046187, 9364.578593963288, 9437.103475169848, 9637.325387222827, 17732.822671773374, 17764.934103953805, 17807.19867605961, 17826.37607683725, 17844.0, 6125.632462052291, 6131.448169664752, 6251.0, 6261.123442718023, 6294.905576416358, 3347.0962840033053, 3458.3774920514547, 3502.8949131526097, 3512.473129030615, 3535.0, 2713.769329606966, 2773.597828314883, 2809.185336252464, 2819.323362393011, 3045.5279431688123, 543.9728013599304, 544.3386285662939, 551.969641669712, 553.7701853730737, 562.8508445262008, 530.973451327432, 545.165896178847, 593.5904226083989, 602.8703828676855, 614.1248720573166, 8108.8378232435025, 8217.506949583045, 8253.257206851413, 8379.958100209582, 8674.038653118127, 491.00571343029935, 549.2859282932172, 570.9209593867594, 607.8055022392792, 608.5861614102364, 3869.1294458746556, 3956.7625942443547, 3986.282469155522, 4156.236341240482, 4175.123224122907, 53680.73159634177, 60887.69556152191, 98509.0, 100166.4991675037, 102178.48910755548, 83675.0, 83813.58093209495, 84102.57948710218, 85312.0, 85372.57313713516, 72827.63586182035, 74513.25486745172, 75981.24018759852, 75989.24010759933, 77032.61483692657, 7781.844363112593, 7905.446618736633, 7946.364290856834, 8011.599420029092, 8244.093149753402, 29128.12615621535, 35884.64115358813, 37583.43624845684, 40293.39559906545, 42152.78923605485, 34338.31323373569, 36397.636023639425, 36999.63000369962, 47530.52469475399, 50716.49283507118, 11488.138389620979, 11532.481038353462, 11642.0, 11893.881061189277, 11906.76186476283, 12683.175593586388, 12774.61676149717, 12836.16564923277, 13245.602631921058, 13459.05786594929, 11299.491522881655, 11303.71740706456, 11621.6513504595, 12209.69475763113, 12232.266064036186, 10760.46197690128, 11149.554017839195, 11252.212345135762, 11322.716932076764, 12167.878321216675, 10814.134869210602, 11167.38579378142, 11559.0, 11578.478968446609, 11586.478608462809, 9530.475823829756, 9558.522073896416, 9702.466364350028, 9867.506624668595, 9905.108540231413, 9261.67584134552, 9904.207663387057, 10093.14208292274, 10102.747431314276, 10127.696169114939], "value": 6323.747857022144, "unit": "score"}], "name": "dromaeo_css", "value": 6282.680986565183, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 115.0, 114.0, 113.0, 116.0, 116.0, 115.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 133.0, 141.0, 176.0, 127.0, 126.0, 132.0, 125.0, 158.0, 125.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 160.0, 160.0, 161.0, 163.0, 161.0, 162.0, 159.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 115.0, 77.0, 78.0, 77.0, 77.0, 117.0, 77.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 130.0, 83.0, 83.0, 83.0, 112.0, 82.0, 84.0, 122.0], "value": 94.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 68.0, 64.0, 65.0, 65.0, 65.0, 67.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 85.0, 89.0, 85.0, 81.0, 82.0, 82.0, 82.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 137.0, 136.0, 136.0, 137.0, 137.0, 136.0, 138.0, 185.0, 146.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 176.0, 175.0, 174.0, 174.0, 175.0, 173.0, 172.0, 174.0, 171.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 70.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1555.6, "alertThreshold": 2.0}]} 11:41:04 INFO - Return code: 0 11:41:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:41:04 INFO - # TBPL SUCCESS # 11:41:04 INFO - Running post-action listener: _resource_record_post_action 11:41:04 INFO - [mozharness: 2016-10-11 18:41:04.589296Z] Finished run-tests step (success) 11:41:04 INFO - Running post-run listener: _resource_record_post_run 11:41:04 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 499712; Write bytes: 392855552; Read time: 216; Write time: 242116 11:41:04 INFO - TinderboxPrint: CPU usage
13.0% 11:41:04 INFO - TinderboxPrint: I/O read bytes / time
499,712 / 216 11:41:04 INFO - TinderboxPrint: I/O write bytes / time
392,855,552 / 242,116 11:41:04 INFO - TinderboxPrint: CPU idle
8,350.5 (87.0%) 11:41:04 INFO - TinderboxPrint: CPU user
1,201.6 (12.5%) 11:41:04 INFO - TinderboxPrint: Swap in / out
0 / 0 11:41:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99950592; Read time: 0; Write time: 75756 11:41:04 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 495616; Write bytes: 292904960; Read time: 200; Write time: 166360 11:41:05 INFO - Running post-run listener: _upload_blobber_files 11:41:05 INFO - Blob upload gear active. 11:41:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:41:05 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 11:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:41:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:41:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:41:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:06 INFO - (blobuploader) - INFO - Done attempting. 11:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:07 INFO - (blobuploader) - INFO - Done attempting. 11:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:41:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:41:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:41:11 INFO - (blobuploader) - INFO - Done attempting. 11:41:11 INFO - (blobuploader) - INFO - Iteration through files over. 11:41:11 INFO - Return code: 0 11:41:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:41:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:41:11 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edae4c56c0524f855dcec895f4326c6fc8f4fba5a8eade0f9b119bf0316af0d2da6646da452bb28b534a95f86bdeffb37a3eb55fdfe177206b082268169a5587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/898b09a6e10ff54d360f3b59d88a6c116c8764eceb6701235799d048e8c1a9e23a2526e42838898acf3ec23ef3ef0ab559be4b0d0e3cb7bf90bdf5489cdf3743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761bfd703c41acd7282e969701d24661bff2866badbcbf4a7bb53829f8e447a68eae12db7f4cc5824d939628f295f13f9a7a87f020701c63dd13a5c494d0b3fc"} 11:41:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:41:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:41:11 INFO - Contents: 11:41:11 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edae4c56c0524f855dcec895f4326c6fc8f4fba5a8eade0f9b119bf0316af0d2da6646da452bb28b534a95f86bdeffb37a3eb55fdfe177206b082268169a5587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/898b09a6e10ff54d360f3b59d88a6c116c8764eceb6701235799d048e8c1a9e23a2526e42838898acf3ec23ef3ef0ab559be4b0d0e3cb7bf90bdf5489cdf3743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761bfd703c41acd7282e969701d24661bff2866badbcbf4a7bb53829f8e447a68eae12db7f4cc5824d939628f295f13f9a7a87f020701c63dd13a5c494d0b3fc"} 11:41:11 INFO - Running post-run listener: copy_logs_to_upload_dir 11:41:11 INFO - Copying logs to upload dir... 11:41:11 INFO - mkdir: /builds/slave/test/build/upload/logs 11:41:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.067515 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-11 11:41:11.726218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 11:41:11.732248) ========= 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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edae4c56c0524f855dcec895f4326c6fc8f4fba5a8eade0f9b119bf0316af0d2da6646da452bb28b534a95f86bdeffb37a3eb55fdfe177206b082268169a5587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/898b09a6e10ff54d360f3b59d88a6c116c8764eceb6701235799d048e8c1a9e23a2526e42838898acf3ec23ef3ef0ab559be4b0d0e3cb7bf90bdf5489cdf3743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761bfd703c41acd7282e969701d24661bff2866badbcbf4a7bb53829f8e447a68eae12db7f4cc5824d939628f295f13f9a7a87f020701c63dd13a5c494d0b3fc"} build_url:https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/EDznHNRAT-OmyNuqHxjPEQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/edae4c56c0524f855dcec895f4326c6fc8f4fba5a8eade0f9b119bf0316af0d2da6646da452bb28b534a95f86bdeffb37a3eb55fdfe177206b082268169a5587", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/898b09a6e10ff54d360f3b59d88a6c116c8764eceb6701235799d048e8c1a9e23a2526e42838898acf3ec23ef3ef0ab559be4b0d0e3cb7bf90bdf5489cdf3743", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/761bfd703c41acd7282e969701d24661bff2866badbcbf4a7bb53829f8e447a68eae12db7f4cc5824d939628f295f13f9a7a87f020701c63dd13a5c494d0b3fc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 11:41:11.758713) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:41:11.759129) ========= 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=0333a256a5e4f052382dd180000001b1-1476210023.135307-1102637393 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 11:41:11.844835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 11:41:11.845211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 11:41:11.845554) ========= ========= Total master_lag: 0.17 =========