builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-005 starttime: 1475595895.08 results: success (0) buildid: 20161004072900 builduid: 2066f9370eaa47a98838c04b9483d609 revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.078111) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.078477) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.078767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.094615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.094895) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 08:44:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-10-04 08:44:55 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128101 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.236480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.236825) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.288075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:55.288553) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 47615f092e09d8d37d883ca72e35891b242a5d4a --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 47615f092e09d8d37d883ca72e35891b242a5d4a --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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 08:44:55,354 truncating revision to first 12 chars 2016-10-04 08:44:55,354 Setting DEBUG logging. 2016-10-04 08:44:55,354 attempt 1/10 2016-10-04 08:44:55,354 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/47615f092e09?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 08:44:55,731 unpacking tar archive at: fx-team-47615f092e09/testing/mozharness/ program finished with exit code 0 elapsedTime=0.762470 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:56.068865) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:56.069607) ========= script_repo_revision: 47615f092e09d8d37d883ca72e35891b242a5d4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:56.070179) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:56.070494) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 08:44:56.081501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 08:44:56.082078) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:56 INFO - MultiFileLogger online at 20161004 08:44:56 in /builds/slave/test 08:44:56 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 08:44:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:56 INFO - {'append_to_log': False, 08:44:56 INFO - 'base_work_dir': '/builds/slave/test', 08:44:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:44:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:56 INFO - 'branch': 'Fx-Team-Non-PGO', 08:44:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:56 INFO - 'config_files': ('talos/linux_config.py',), 08:44:56 INFO - 'default_actions': ('clobber', 08:44:56 INFO - 'read-buildbot-config', 08:44:56 INFO - 'download-and-extract', 08:44:56 INFO - 'populate-webroot', 08:44:56 INFO - 'create-virtualenv', 08:44:56 INFO - 'install', 08:44:56 INFO - 'run-tests'), 08:44:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:56 INFO - 'download_minidump_stackwalk': True, 08:44:56 INFO - 'download_symbols': 'ondemand', 08:44:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:56 INFO - 'installer_path': 'installer.exe', 08:44:56 INFO - 'log_level': 'info', 08:44:56 INFO - 'log_name': 'talos', 08:44:56 INFO - 'log_to_console': True, 08:44:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:56 INFO - 'opt_config_files': (), 08:44:56 INFO - 'pip_index': False, 08:44:56 INFO - 'sps_profile': False, 08:44:56 INFO - 'sps_profile_interval': 0, 08:44:56 INFO - 'suite': 'dromaeojs', 08:44:56 INFO - 'system_bits': '32', 08:44:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:56 INFO - 'title': 'talos-linux64-ix-005', 08:44:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:56 INFO - 'use_talos_json': True, 08:44:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:56 INFO - 'work_dir': 'build'} 08:44:56 INFO - [mozharness: 2016-10-04 15:44:56.244703Z] Running clobber step. 08:44:56 INFO - Running pre-action listener: _resource_record_pre_action 08:44:56 INFO - Running main action method: clobber 08:44:56 INFO - rmtree: /builds/slave/test/build 08:44:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:56 INFO - Running post-action listener: _resource_record_post_action 08:44:56 INFO - [mozharness: 2016-10-04 15:44:56.698205Z] Finished clobber step (success) 08:44:56 INFO - [mozharness: 2016-10-04 15:44:56.698305Z] Running read-buildbot-config step. 08:44:56 INFO - Running pre-action listener: _resource_record_pre_action 08:44:56 INFO - Running main action method: read_buildbot_config 08:44:56 INFO - Using buildbot properties: 08:44:56 INFO - { 08:44:56 INFO - "project": "", 08:44:56 INFO - "product": "firefox", 08:44:56 INFO - "script_repo_revision": "production", 08:44:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:44:56 INFO - "repository": "", 08:44:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:44:56 INFO - "buildid": "20161004072900", 08:44:56 INFO - "pgo_build": "False", 08:44:56 INFO - "basedir": "/builds/slave/test", 08:44:56 INFO - "buildnumber": 1964, 08:44:56 INFO - "slavename": "talos-linux64-ix-005", 08:44:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:56 INFO - "platform": "ubuntu64_hw", 08:44:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:44:56 INFO - "branch": "fx-team", 08:44:56 INFO - "repo_path": "integration/fx-team", 08:44:56 INFO - "revision": "47615f092e09d8d37d883ca72e35891b242a5d4a", 08:44:56 INFO - "stage_platform": "linux64", 08:44:56 INFO - "builduid": "2066f9370eaa47a98838c04b9483d609", 08:44:56 INFO - "slavebuilddir": "test" 08:44:56 INFO - } 08:44:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:44:56 INFO - Running post-action listener: _resource_record_post_action 08:44:56 INFO - [mozharness: 2016-10-04 15:44:56.700717Z] Finished read-buildbot-config step (success) 08:44:56 INFO - [mozharness: 2016-10-04 15:44:56.700805Z] Running download-and-extract step. 08:44:56 INFO - Running pre-action listener: _resource_record_pre_action 08:44:56 INFO - Running main action method: download_and_extract 08:44:56 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:56 INFO - trying https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:44:56 INFO - Downloading https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/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 08:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/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 08:44:57 INFO - Downloaded 1361 bytes. 08:44:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:44:57 INFO - Using the following test package requirements: 08:44:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:44:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'jsshell-linux-x86_64.zip'], 08:44:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:44:57 INFO - Http code: 200 08:44:57 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:44:57 INFO - x-amz-cf-id: c9ahe2Mf_klfEeHyGx7tLRo2b28zbopJ1XpKkyfLo6EUKs2VFV_Pow== 08:44:57 INFO - x-amz-version-id: HhyJJdPkvne5BbGTQvtXd.cyIHJyQMWG 08:44:58 INFO - Expected file size: 20421126 08:44:58 INFO - Obtained file size: 20421126 08:45:02 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 08:45:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:45:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:02 INFO - Fetch https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:45:03 INFO - Http code: 200 08:45:03 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 08:45:03 INFO - x-amz-cf-id: mzzogVUs1JJbUocQhZwvmkFNm3LhaBkT91831eex0myucx1QjCNO2g== 08:45:03 INFO - x-amz-version-id: HhyJJdPkvne5BbGTQvtXd.cyIHJyQMWG 08:45:03 INFO - Expected file size: 20421126 08:45:03 INFO - Obtained file size: 20421126 08:45:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:45:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:45:08 INFO - Http code: 200 08:45:08 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:45:08 INFO - x-amz-cf-id: cD-2ZZhRe9_DLiF7YUoWnYhnm3ACK-HSEDXg72NMY5pFfG8bmVCAAw== 08:45:08 INFO - x-amz-version-id: XcSkRjfTJjj2Dfs3OizNtxT0vwn38f0a 08:45:09 INFO - Expected file size: 14409006 08:45:09 INFO - Obtained file size: 14409006 08:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:09 INFO - trying https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:09 INFO - Downloading https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/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 08:45:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/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 08:45:11 INFO - Downloaded 55796186 bytes. 08:45:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:11 INFO - mkdir: /builds/slave/test/properties 08:45:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:11 INFO - Contents: 08:45:11 INFO - build_url:https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:45:12 INFO - Running post-action listener: _resource_record_post_action 08:45:12 INFO - Running post-action listener: set_extra_try_arguments 08:45:12 INFO - [mozharness: 2016-10-04 15:45:12.366610Z] Finished download-and-extract step (success) 08:45:12 INFO - [mozharness: 2016-10-04 15:45:12.366837Z] Running populate-webroot step. 08:45:12 INFO - Running pre-action listener: _resource_record_pre_action 08:45:12 INFO - Running main action method: populate_webroot 08:45:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:12 INFO - '--tppagecycles', 08:45:12 INFO - '7'], 08:45:12 INFO - 'tests': ['tsvgm']}}, 08:45:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['damp', 'tps']}, 08:45:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'tests': ['damp', 'tps']}, 08:45:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['dromaeo_dom']}, 08:45:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['basic_compositor_video']}, 08:45:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['a11yr', 08:45:12 INFO - 'ts_paint', 08:45:12 INFO - 'tpaint', 08:45:12 INFO - 'sessionrestore', 08:45:12 INFO - 'sessionrestore_no_auto_restore', 08:45:12 INFO - 'tabpaint']}, 08:45:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['tsvgx', 08:45:12 INFO - 'tsvgr_opacity', 08:45:12 INFO - 'tart', 08:45:12 INFO - 'tscrollx', 08:45:12 INFO - 'cart']}, 08:45:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:12 INFO - 'tsvgr_opacity', 08:45:12 INFO - 'tart', 08:45:12 INFO - 'tscrollx', 08:45:12 INFO - 'cart']}, 08:45:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'talos_options': ['--disable-e10s'], 08:45:12 INFO - 'tests': ['tp5o']}, 08:45:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'tests': ['tp5o']}, 08:45:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'talos_options': ['--disable-e10s', 08:45:12 INFO - '--xperf_path', 08:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:12 INFO - 'tests': ['tp5n']}, 08:45:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:12 INFO - 'talos_options': ['--xperf_path', 08:45:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:12 INFO - 'tests': ['tp5n']}}, 08:45:12 INFO - 'talos.zip': {'path': '', 08:45:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:12 INFO - Running post-action listener: _resource_record_post_action 08:45:12 INFO - [mozharness: 2016-10-04 15:45:12.386543Z] Finished populate-webroot step (success) 08:45:12 INFO - [mozharness: 2016-10-04 15:45:12.386631Z] Running create-virtualenv step. 08:45:12 INFO - Running pre-action listener: _resource_record_pre_action 08:45:12 INFO - Running main action method: create_virtualenv 08:45:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:12 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 08:45:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:12 INFO - Using real prefix '/usr' 08:45:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:14 INFO - Installing pip.................done. 08:45:14 INFO - Return code: 0 08:45:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:15 INFO - Reading from file tmpfile_stdout 08:45:15 INFO - Output received: 08:45:15 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) 08:45:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:15 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')]} 08:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 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')]} 08:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:15 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 08:45:15 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 08:45:15 INFO - Using env: {'DISPLAY': ':0', 08:45:15 INFO - 'HOME': '/home/cltbld', 08:45:15 INFO - 'LANG': 'en_US.UTF-8', 08:45:15 INFO - 'LANGUAGE': 'en_US:en', 08:45:15 INFO - 'LOGNAME': 'cltbld', 08:45:15 INFO - 'MAIL': '/var/mail/cltbld', 08:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:15 INFO - 'MOZ_NO_REMOTE': '1', 08:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:15 INFO - 'NO_EM_RESTART': '1', 08:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:15 INFO - 'PWD': '/builds/slave/test', 08:45:15 INFO - 'SHELL': '/bin/bash', 08:45:15 INFO - 'SHLVL': '1', 08:45:15 INFO - 'TERM': 'linux', 08:45:15 INFO - 'TMOUT': '86400', 08:45:15 INFO - 'USER': 'cltbld', 08:45:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:15 INFO - '_': '/tools/buildbot/bin/python'} 08:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:15 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 08:45:15 INFO - Cleaning up... 08:45:15 INFO - Return code: 0 08:45:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:15 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')]} 08:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 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')]} 08:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:15 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 08:45:15 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 08:45:15 INFO - Using env: {'DISPLAY': ':0', 08:45:15 INFO - 'HOME': '/home/cltbld', 08:45:15 INFO - 'LANG': 'en_US.UTF-8', 08:45:15 INFO - 'LANGUAGE': 'en_US:en', 08:45:15 INFO - 'LOGNAME': 'cltbld', 08:45:15 INFO - 'MAIL': '/var/mail/cltbld', 08:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:15 INFO - 'MOZ_NO_REMOTE': '1', 08:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:15 INFO - 'NO_EM_RESTART': '1', 08:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:15 INFO - 'PWD': '/builds/slave/test', 08:45:15 INFO - 'SHELL': '/bin/bash', 08:45:15 INFO - 'SHLVL': '1', 08:45:15 INFO - 'TERM': 'linux', 08:45:15 INFO - 'TMOUT': '86400', 08:45:15 INFO - 'USER': 'cltbld', 08:45:15 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:15 INFO - '_': '/tools/buildbot/bin/python'} 08:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:15 INFO - Downloading/unpacking psutil>=3.1.1 08:45:15 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 08:45:15 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 08:45:15 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 08:45:15 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 08:45:15 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 08:45:15 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 08:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:17 INFO - Installing collected packages: psutil 08:45:17 INFO - Running setup.py install for psutil 08:45:17 INFO - building 'psutil._psutil_linux' extension 08:45:17 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 08:45:17 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 08:45:17 INFO - building 'psutil._psutil_posix' extension 08:45:17 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 08:45:17 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 08:45:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:18 INFO - Successfully installed psutil 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:45:18 INFO - Using env: {'DISPLAY': ':0', 08:45:18 INFO - 'HOME': '/home/cltbld', 08:45:18 INFO - 'LANG': 'en_US.UTF-8', 08:45:18 INFO - 'LANGUAGE': 'en_US:en', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MAIL': '/var/mail/cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SHLVL': '1', 08:45:18 INFO - 'TERM': 'linux', 08:45:18 INFO - 'TMOUT': '86400', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - '_': '/tools/buildbot/bin/python'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:20 INFO - Installing collected packages: mozsystemmonitor 08:45:20 INFO - Running setup.py install for mozsystemmonitor 08:45:20 INFO - Successfully installed mozsystemmonitor 08:45:20 INFO - Cleaning up... 08:45:20 INFO - Return code: 0 08:45:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:20 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:20 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 08:45:20 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 08:45:20 INFO - Using env: {'DISPLAY': ':0', 08:45:20 INFO - 'HOME': '/home/cltbld', 08:45:20 INFO - 'LANG': 'en_US.UTF-8', 08:45:20 INFO - 'LANGUAGE': 'en_US:en', 08:45:20 INFO - 'LOGNAME': 'cltbld', 08:45:20 INFO - 'MAIL': '/var/mail/cltbld', 08:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:20 INFO - 'MOZ_NO_REMOTE': '1', 08:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:20 INFO - 'NO_EM_RESTART': '1', 08:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:20 INFO - 'PWD': '/builds/slave/test', 08:45:20 INFO - 'SHELL': '/bin/bash', 08:45:20 INFO - 'SHLVL': '1', 08:45:20 INFO - 'TERM': 'linux', 08:45:20 INFO - 'TMOUT': '86400', 08:45:20 INFO - 'USER': 'cltbld', 08:45:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:20 INFO - '_': '/tools/buildbot/bin/python'} 08:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:20 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 08:45:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:22 INFO - warning: no files found matching '*.txt' 08:45:22 INFO - no previously-included directories found matching 'build' 08:45:22 INFO - no previously-included directories found matching 'dist' 08:45:22 INFO - no previously-included directories found matching '.git*' 08:45:22 INFO - Installing collected packages: jsonschema, functools32 08:45:22 INFO - Running setup.py install for functools32 08:45:23 INFO - warning: no files found matching '*.txt' 08:45:23 INFO - no previously-included directories found matching 'build' 08:45:23 INFO - no previously-included directories found matching 'dist' 08:45:23 INFO - no previously-included directories found matching '.git*' 08:45:23 INFO - Successfully installed jsonschema functools32 08:45:23 INFO - Cleaning up... 08:45:23 INFO - Return code: 0 08:45:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:45:23 INFO - Using env: {'DISPLAY': ':0', 08:45:23 INFO - 'HOME': '/home/cltbld', 08:45:23 INFO - 'LANG': 'en_US.UTF-8', 08:45:23 INFO - 'LANGUAGE': 'en_US:en', 08:45:23 INFO - 'LOGNAME': 'cltbld', 08:45:23 INFO - 'MAIL': '/var/mail/cltbld', 08:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:23 INFO - 'MOZ_NO_REMOTE': '1', 08:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:23 INFO - 'NO_EM_RESTART': '1', 08:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:23 INFO - 'PWD': '/builds/slave/test', 08:45:23 INFO - 'SHELL': '/bin/bash', 08:45:23 INFO - 'SHLVL': '1', 08:45:23 INFO - 'TERM': 'linux', 08:45:23 INFO - 'TMOUT': '86400', 08:45:23 INFO - 'USER': 'cltbld', 08:45:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:23 INFO - '_': '/tools/buildbot/bin/python'} 08:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:23 INFO - Cleaning up... 08:45:23 INFO - Return code: 0 08:45:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:23 INFO - Using env: {'DISPLAY': ':0', 08:45:23 INFO - 'HOME': '/home/cltbld', 08:45:23 INFO - 'LANG': 'en_US.UTF-8', 08:45:23 INFO - 'LANGUAGE': 'en_US:en', 08:45:23 INFO - 'LOGNAME': 'cltbld', 08:45:23 INFO - 'MAIL': '/var/mail/cltbld', 08:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:23 INFO - 'MOZ_NO_REMOTE': '1', 08:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:23 INFO - 'NO_EM_RESTART': '1', 08:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:23 INFO - 'PWD': '/builds/slave/test', 08:45:23 INFO - 'SHELL': '/bin/bash', 08:45:23 INFO - 'SHLVL': '1', 08:45:23 INFO - 'TERM': 'linux', 08:45:23 INFO - 'TMOUT': '86400', 08:45:23 INFO - 'USER': 'cltbld', 08:45:23 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:23 INFO - '_': '/tools/buildbot/bin/python'} 08:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:23 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 08:45:23 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 08:45:23 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 08:45:23 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 08:45:23 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 08:45:23 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 08:45:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - Downloading docopt-0.6.1.tar.gz 08:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:26 INFO - Running setup.py install for blobuploader 08:45:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:26 INFO - Running setup.py install for requests 08:45:26 INFO - Running setup.py install for docopt 08:45:26 INFO - Successfully installed blobuploader requests docopt 08:45:26 INFO - Cleaning up... 08:45:26 INFO - Return code: 0 08:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:26 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:26 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 08:45:26 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 08:45:26 INFO - Using env: {'DISPLAY': ':0', 08:45:26 INFO - 'HOME': '/home/cltbld', 08:45:26 INFO - 'LANG': 'en_US.UTF-8', 08:45:26 INFO - 'LANGUAGE': 'en_US:en', 08:45:26 INFO - 'LOGNAME': 'cltbld', 08:45:26 INFO - 'MAIL': '/var/mail/cltbld', 08:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:26 INFO - 'MOZ_NO_REMOTE': '1', 08:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:26 INFO - 'NO_EM_RESTART': '1', 08:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:26 INFO - 'PWD': '/builds/slave/test', 08:45:26 INFO - 'SHELL': '/bin/bash', 08:45:26 INFO - 'SHLVL': '1', 08:45:26 INFO - 'TERM': 'linux', 08:45:26 INFO - 'TMOUT': '86400', 08:45:26 INFO - 'USER': 'cltbld', 08:45:26 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:26 INFO - '_': '/tools/buildbot/bin/python'} 08:45:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:27 INFO - Running setup.py (path:/tmp/pip-QzpRvB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:27 INFO - Running setup.py (path:/tmp/pip-XSd9P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:27 INFO - Running setup.py (path:/tmp/pip-jUMbpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:27 INFO - Running setup.py (path:/tmp/pip-Reud9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:27 INFO - Running setup.py (path:/tmp/pip-GPkCOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:27 INFO - Running setup.py (path:/tmp/pip-sv9dVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:27 INFO - Running setup.py (path:/tmp/pip-WwAx4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:27 INFO - Running setup.py (path:/tmp/pip-iDx3GI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:27 INFO - Running setup.py (path:/tmp/pip-8eIjjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:27 INFO - Running setup.py (path:/tmp/pip-RTajD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:27 INFO - Running setup.py (path:/tmp/pip-1BZKmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:27 INFO - Running setup.py (path:/tmp/pip-Qk0UBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:27 INFO - Running setup.py (path:/tmp/pip-BNvB_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:27 INFO - Running setup.py (path:/tmp/pip-MUycKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:28 INFO - Running setup.py (path:/tmp/pip-ROxpNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:28 INFO - Running setup.py (path:/tmp/pip-a9r_fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:28 INFO - Running setup.py (path:/tmp/pip-4TyInC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:28 INFO - Running setup.py install for manifestparser 08:45:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozcrash 08:45:28 INFO - Running setup.py install for mozdebug 08:45:28 INFO - Running setup.py install for mozdevice 08:45:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozfile 08:45:28 INFO - Running setup.py install for mozhttpd 08:45:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozinfo 08:45:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozInstall 08:45:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozleak 08:45:29 INFO - Running setup.py install for mozlog 08:45:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for moznetwork 08:45:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozprocess 08:45:29 INFO - Running setup.py install for mozprofile 08:45:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozrunner 08:45:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:29 INFO - Running setup.py install for mozscreenshot 08:45:29 INFO - Running setup.py install for moztest 08:45:29 INFO - Running setup.py install for mozversion 08:45:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:30 INFO - Cleaning up... 08:45:30 INFO - Return code: 0 08:45:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:30 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:30 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 08:45:30 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 08:45:30 INFO - Using env: {'DISPLAY': ':0', 08:45:30 INFO - 'HOME': '/home/cltbld', 08:45:30 INFO - 'LANG': 'en_US.UTF-8', 08:45:30 INFO - 'LANGUAGE': 'en_US:en', 08:45:30 INFO - 'LOGNAME': 'cltbld', 08:45:30 INFO - 'MAIL': '/var/mail/cltbld', 08:45:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:30 INFO - 'MOZ_NO_REMOTE': '1', 08:45:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:30 INFO - 'NO_EM_RESTART': '1', 08:45:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:30 INFO - 'PWD': '/builds/slave/test', 08:45:30 INFO - 'SHELL': '/bin/bash', 08:45:30 INFO - 'SHLVL': '1', 08:45:30 INFO - 'TERM': 'linux', 08:45:30 INFO - 'TMOUT': '86400', 08:45:30 INFO - 'USER': 'cltbld', 08:45:30 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:30 INFO - '_': '/tools/buildbot/bin/python'} 08:45:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 INFO - Running setup.py (path:/tmp/pip-XqRdYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 INFO - Running setup.py (path:/tmp/pip-t_Pa2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 INFO - Running setup.py (path:/tmp/pip-n8BbHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:30 INFO - Running setup.py (path:/tmp/pip-ZL9fhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:30 INFO - Running setup.py (path:/tmp/pip-jvH_5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:30 INFO - Running setup.py (path:/tmp/pip-CO26dH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:30 INFO - Running setup.py (path:/tmp/pip-SAr6ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:30 INFO - Running setup.py (path:/tmp/pip-FB_rWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:30 INFO - Running setup.py (path:/tmp/pip-Rjypvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:30 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)) 08:45:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:30 INFO - Running setup.py (path:/tmp/pip-NT9VWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:30 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 INFO - Running setup.py (path:/tmp/pip-QAMYXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 INFO - Running setup.py (path:/tmp/pip-rvY5tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:31 INFO - Running setup.py (path:/tmp/pip-ssboix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:31 INFO - Running setup.py (path:/tmp/pip-7TecVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:31 INFO - Running setup.py (path:/tmp/pip-__m0su-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:31 INFO - Running setup.py (path:/tmp/pip-XjQXMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:31 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)) 08:45:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:31 INFO - Running setup.py (path:/tmp/pip-q2ixJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 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)) 08:45:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:33 INFO - Downloading blessings-1.6.tar.gz 08:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:33 INFO - Installing collected packages: blessings 08:45:33 INFO - Running setup.py install for blessings 08:45:33 INFO - Successfully installed blessings 08:45:33 INFO - Cleaning up... 08:45:33 INFO - Return code: 0 08:45:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Current package versions: 08:45:34 INFO - argparse == 1.2.1 08:45:34 INFO - blessings == 1.6 08:45:34 INFO - blobuploader == 1.2.4 08:45:34 INFO - docopt == 0.6.1 08:45:34 INFO - functools32 == 3.2.3-2 08:45:34 INFO - jsonschema == 2.5.1 08:45:34 INFO - manifestparser == 1.1 08:45:34 INFO - mozInstall == 1.12 08:45:34 INFO - mozcrash == 0.17 08:45:34 INFO - mozdebug == 0.1 08:45:34 INFO - mozdevice == 0.48 08:45:34 INFO - mozfile == 1.2 08:45:34 INFO - mozhttpd == 0.7 08:45:34 INFO - mozinfo == 0.9 08:45:34 INFO - mozleak == 0.1 08:45:34 INFO - mozlog == 3.4 08:45:34 INFO - moznetwork == 0.27 08:45:34 INFO - mozprocess == 0.23 08:45:34 INFO - mozprofile == 0.28 08:45:34 INFO - mozrunner == 6.12 08:45:34 INFO - mozscreenshot == 0.1 08:45:34 INFO - mozsystemmonitor == 0.3 08:45:34 INFO - moztest == 0.7 08:45:34 INFO - mozversion == 1.4 08:45:34 INFO - psutil == 3.1.1 08:45:34 INFO - requests == 1.2.3 08:45:34 INFO - wsgiref == 0.1.2 08:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:34 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:34 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 08:45:34 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 08:45:34 INFO - Using env: {'DISPLAY': ':0', 08:45:34 INFO - 'HOME': '/home/cltbld', 08:45:34 INFO - 'LANG': 'en_US.UTF-8', 08:45:34 INFO - 'LANGUAGE': 'en_US:en', 08:45:34 INFO - 'LOGNAME': 'cltbld', 08:45:34 INFO - 'MAIL': '/var/mail/cltbld', 08:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:34 INFO - 'MOZ_NO_REMOTE': '1', 08:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:34 INFO - 'NO_EM_RESTART': '1', 08:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:34 INFO - 'PWD': '/builds/slave/test', 08:45:34 INFO - 'SHELL': '/bin/bash', 08:45:34 INFO - 'SHLVL': '1', 08:45:34 INFO - 'TERM': 'linux', 08:45:34 INFO - 'TMOUT': '86400', 08:45:34 INFO - 'USER': 'cltbld', 08:45:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:34 INFO - '_': '/tools/buildbot/bin/python'} 08:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 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)) 08:45:34 INFO - Cleaning up... 08:45:34 INFO - Return code: 0 08:45:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:34 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 0x7f97611cdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', '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 08:45:34 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 08:45:34 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 08:45:34 INFO - Using env: {'DISPLAY': ':0', 08:45:34 INFO - 'HOME': '/home/cltbld', 08:45:34 INFO - 'LANG': 'en_US.UTF-8', 08:45:34 INFO - 'LANGUAGE': 'en_US:en', 08:45:34 INFO - 'LOGNAME': 'cltbld', 08:45:34 INFO - 'MAIL': '/var/mail/cltbld', 08:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:34 INFO - 'MOZ_NO_REMOTE': '1', 08:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:34 INFO - 'NO_EM_RESTART': '1', 08:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:34 INFO - 'PWD': '/builds/slave/test', 08:45:34 INFO - 'SHELL': '/bin/bash', 08:45:34 INFO - 'SHLVL': '1', 08:45:34 INFO - 'TERM': 'linux', 08:45:34 INFO - 'TMOUT': '86400', 08:45:34 INFO - 'USER': 'cltbld', 08:45:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:34 INFO - '_': '/tools/buildbot/bin/python'} 08:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:34 INFO - Cleaning up... 08:45:34 INFO - Return code: 0 08:45:34 INFO - Running post-action listener: _resource_record_post_action 08:45:34 INFO - Running post-action listener: _start_resource_monitoring 08:45:34 INFO - Starting resource monitoring. 08:45:34 INFO - [mozharness: 2016-10-04 15:45:34.593788Z] Finished create-virtualenv step (success) 08:45:34 INFO - [mozharness: 2016-10-04 15:45:34.594288Z] Running install step. 08:45:34 INFO - Running pre-action listener: _resource_record_pre_action 08:45:34 INFO - Running main action method: install 08:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:34 INFO - Reading from file tmpfile_stdout 08:45:34 INFO - Output received: 08:45:34 INFO - Usage: mozinstall [options] installer 08:45:34 INFO - Options: 08:45:34 INFO - -h, --help show this help message and exit 08:45:34 INFO - -d DEST, --destination=DEST 08:45:34 INFO - Directory to install application into. [default: 08:45:34 INFO - "/builds/slave/test"] 08:45:34 INFO - --app=APP Application being installed. [default: firefox] 08:45:34 INFO - mkdir: /builds/slave/test/build/application 08:45:34 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'] 08:45:34 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 08:45:51 INFO - Reading from file tmpfile_stdout 08:45:51 INFO - Output received: 08:45:51 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:51 INFO - Running post-action listener: _resource_record_post_action 08:45:51 INFO - [mozharness: 2016-10-04 15:45:51.008505Z] Finished install step (success) 08:45:51 INFO - [mozharness: 2016-10-04 15:45:51.008750Z] Running run-tests step. 08:45:51 INFO - Running pre-action listener: _resource_record_pre_action 08:45:51 INFO - Running main action method: run_tests 08:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:51 INFO - Python 2.7.3 08:45:51 INFO - Return code: 0 08:45:51 INFO - grabbing minidump binary from tooltool 08:45:51 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')]} 08:45:51 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 0x1028f60>, '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 0x1029d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:51 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 08:45:51 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 08:45:51 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 08:45:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:51 INFO - Return code: 0 08:45:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:51 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/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:45:51 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/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 08:45:51 INFO - Using env: {'DISPLAY': ':0', 08:45:51 INFO - 'HOME': '/home/cltbld', 08:45:51 INFO - 'LANG': 'en_US.UTF-8', 08:45:51 INFO - 'LANGUAGE': 'en_US:en', 08:45:51 INFO - 'LOGNAME': 'cltbld', 08:45:51 INFO - 'MAIL': '/var/mail/cltbld', 08:45:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:51 INFO - 'MOZ_NO_REMOTE': '1', 08:45:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:51 INFO - 'NO_EM_RESTART': '1', 08:45:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:51 INFO - 'PWD': '/builds/slave/test', 08:45:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:51 INFO - 'SHELL': '/bin/bash', 08:45:51 INFO - 'SHLVL': '1', 08:45:51 INFO - 'TERM': 'linux', 08:45:51 INFO - 'TMOUT': '86400', 08:45:51 INFO - 'USER': 'cltbld', 08:45:51 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703', 08:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:51 INFO - '_': '/tools/buildbot/bin/python'} 08:45:51 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/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 08:45:51 INFO - mozversion application_buildid: 20161004072900 08:45:51 INFO - mozversion application_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 08:45:51 INFO - mozversion application_display_name: Nightly 08:45:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:51 INFO - mozversion application_name: Firefox 08:45:51 INFO - mozversion application_remotingname: firefox 08:45:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:45:51 INFO - mozversion application_vendor: Mozilla 08:45:51 INFO - mozversion application_version: 52.0a1 08:45:51 INFO - mozversion platform_buildid: 20161004072900 08:45:51 INFO - mozversion platform_changeset: 47615f092e09d8d37d883ca72e35891b242a5d4a 08:45:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:45:51 INFO - mozversion platform_version: 52.0a1 08:45:51 INFO - using testdate: 1475595951 08:45:51 INFO - actual date: 1475595951 08:45:51 INFO - starting webserver on 'localhost:39343' 08:45:51 INFO - SUITE-START | Running 2 tests 08:45:51 INFO - TEST-START | dromaeo_css 08:45:51 INFO - operating with platform_type : linux_ 08:45:51 INFO - Initialising browser for dromaeo_css test... 08:45:51 INFO - TEST-INFO | started process 6153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXW2vDh/profile http://localhost:39343/getInfo.html) 08:45:55 INFO - PROCESS | 6153 | __metrics Screen width/height:1600/1200 08:45:55 INFO - PROCESS | 6153 | colorDepth:24 08:45:55 INFO - PROCESS | 6153 | Browser inner width/height: 1024/697 08:45:55 INFO - PROCESS | 6153 | __metrics 08:45:56 INFO - PROCESS | 6153 | 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" 08:45:56 INFO - PROCESS | 6153 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:56 INFO - PROCESS | 6153 | console.error: PushService: 08:45:56 INFO - PROCESS | 6153 | stateChangeProcessEnqueue: Error transitioning state 08:45:56 INFO - PROCESS | 6153 | UnknownError 08:45:57 INFO - TEST-INFO | 6153: exit 0 08:45:57 INFO - Browser initialized. 08:45:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:57 INFO - TEST-INFO | started process 6233 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXW2vDh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:09 INFO - PROCESS | 6233 | RSS: Main: 175362048 08:46:09 INFO - PROCESS | 6233 | 08:47:00 INFO - PROCESS | 6233 | 1475596020776 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] 08:49:14 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39343/tests/dromaeo/cssquery-ext.html) 08:49:16 INFO - PROCESS | 6233 | RSS: Main: 294277120 08:49:16 INFO - PROCESS | 6233 | 08:52:18 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-ext.html (next: http://localhost:39343/tests/dromaeo/cssquery-jquery.html) 08:52:19 INFO - PROCESS | 6233 | RSS: Main: 275283968 08:52:19 INFO - PROCESS | 6233 | 08:55:21 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39343/tests/dromaeo/cssquery-mootools.html) 08:55:21 INFO - PROCESS | 6233 | RSS: Main: 220078080 08:55:21 INFO - PROCESS | 6233 | 08:58:24 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39343/tests/dromaeo/cssquery-prototype.html) 08:58:24 INFO - PROCESS | 6233 | RSS: Main: 219389952 08:58:24 INFO - PROCESS | 6233 | 09:01:27 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39343/tests/dromaeo/cssquery-yui.html) 09:01:28 INFO - PROCESS | 6233 | RSS: Main: 219340800 09:01:28 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | Cycle 1(1): loaded http://localhost:39343/tests/dromaeo/cssquery-yui.html (next: http://localhost:39343/tests/dromaeo/cssquery-dojo.html) 09:04:31 INFO - PROCESS | 6233 | RSS: Main: 306888704 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | __start_tp_report 09:04:31 INFO - PROCESS | 6233 | _x_x_mozilla_page_load 09:04:31 INFO - PROCESS | 6233 | _x_x_mozilla_page_load_details 09:04:31 INFO - PROCESS | 6233 | |i|pagename|runs| 09:04:31 INFO - PROCESS | 6233 | |0;dojo.html;2567.2041667083204;2590.326515106072;2631.2106368089567;2631.842089474632;2651.164883061834;4573.8399156029545;4611.1469378164975;4729.266963620636;4729.527047295269;4754.38193034905;4663.48701642819;4674.813007479705;4715.528447155283;4730.3614012108355;4804.83183088592;4229.7885105744745;4250.61744443;4275.315949448089;4363.040131171138;4388.385626012361;4312.654987600984;4313.633341166004;4364.192624364487;4381.824727010931;4422.7346359218545;4404.581564751344;4411.360352748849;4420.712653677533;4457.465104187502;4466.0844526871915;4220.831166753326;4237.724547904377;4241.130568233505;4302.548232435581;4335.306350983859;4304.203722311382;4305.182015417061;4382.715123516961;4390.912181756347;4391.802368893375;4686.742229177394;4718.339432479455;4724.220503616899;4732.574068333832;4785.186518291899;4915.0661374339115;5057.2161314995865;5059.797608095671;5061.139606266944;5122.257272695439;4912.263160525949;4948.579370753454;4963.702177869303;4988.950110498885;5017.347744793154;4629.86110416688;4633.235516139866;4634.281686338657;4636.4899861015265;4681.67228294023;5062.316587260672;5062.772175252123;5062.797488100435;5068.214426763858;5127.102757017507;4801.591864691541;4850.320955066293;4913.680610760289;4941.184704523714;4970.925436118461;5047.722375269322;5052.595792336604;5056.494350564914;5060.443351231362;5108;4977.726225057584;4986.501349865057;5011.974940125276;5033.0688822567945;5046.823361182341;4765.642576806753;4767.404074490689;4817.9036419271415;4853.39332583427;4975.004999000214;4158.043649960526;4198.3702444633545;4198.769067701244;4232.386303985905;4248.171606536695;3655.6161603031833;3659.853605855736;3663.7984910829628;3698.870539531157;3703.685186759156;4266.722663026893;4322.589354011364;4328;4339.652827773771;4364.279893817485;5001.874953126201;5041.546260836542;5046.39443266803;5070.6957582545165;5118.232265160255;4353.782310884443;4362.192994296065;4374.562543745664;4379.430674012422;4426.424564806554;4396.274614688605;4554.476235232924;4556;4556.134334476439;4586.724796512153;4651.534846515321;4702.365180700698;4730.432348118248;4755.334253204485;4783.354247176726;5042.84871453857;5057.468965758542;5059.19052951526;5067.5185857343495;5117.513836185556;4725.527447255247;4736.928946065881;4746.92879606813;4748.0978614063215;4807.206810876166;4814.325994360723;4829.323894654822;4842.4673285937815;4859.246816743411;4885.511448855086;4921.50784921505;4931.926021109614;4939.60483161339;4940.036692844861;4999.425066117297;4817.9518204817505;4826.879328016687;4834.178189707688;4852.611791056636;4890.877728056827;4734.053189362073;4778.737169455713;4839.95160048395;4848.151573474557;4874.463808980939;4839.491853355487;4850.05423942342;4862.586680132228;4879.048585525788;4896.804127834846;4793.5685788279225;4914.311996320589;4945.86285255983;4955.331030310862;5019.247112933089;4718.315844202502;4726.905461890812;4775.570198682135;4790.9281360780315;4804.2073057946445 09:04:31 INFO - PROCESS | 6233 | |1;ext.html;539.9163129714891;547.7863633183061;551.8868631930454;567.9006173919565;569.8119620525227;26958.86520567397;37620.24759504812;38869.41695874564;38873.61126388739;42158;39320.80339598305;39726.64373700209;39793.20413591734;40013.19973600526;40105.39841902374;7638.083429988409;7784.727534536292;7788.649510772028;7789.571573563452;7792.883106753403;7649.847003059936;7732.381409487228;7767.728129515468;7772.06735191775;7774.689012439496;7784.494007889469;7805.648745806452;7833.490823096509;7835.373170146375;7837.804054898645;7720.1121870985;7727.227277272284;7736.226377362275;7744.0319960005;7760.30157285847;7655.693772249103;7714.61426928657;7728;7738.458307918448;7738.53568785869;37131.443028354595;37427.438588420926;37427.812860935795;37472.063198420256;37489.25021499555;2922.1379692990618;2937.8429968981254;3030.1364111228413;3181.427343078245;3190.888318908827;26899.32751681204;27369.589456158174;27389;27783.722162778315;28055.859720701468;3313.287643156709;3329.4839299908554;3350.229447227127;3386.86452541898;3422.9144271393166;239533;240228;240253;241153;241594;30642.387152257277;48374;48691.269630954856;48779;48817;31222.375552488822;32292.838535807172;32337.191570210933;32338.35323293521;32350.514742278883;12267.57063502773;12476.563320283927;12485.93757031209;12488;12497.375131243401;9378.90621093794;9462.195713364441;9475.28935329853;9477.052294770469;9481.715548533555;7279.6360181990685;7479.065116860393;7516.812079698051;7526.698932042657;7536.171021187774;2885.4084912592866;2901.2601786544296;2942.941141177207;2961.4965455872552;2985.328301132228;827.6383459170139;852.2074470742269;877.8244351129799;912.3431129586687;969.5200875566499;26415.33961650974;26940.865295673397;27258.31854203621;27373;27579.03473378462;761.885717142422;924.4453328003144;947.1475671895212;958.6884262614678;986.3933680786265;13262.933685331705;14345.426182952773;14432.350544225535;14462.566123016326;14491.492797752027;378015.1099244486;380849;381000;381096;382677;47126.76436617795;47359.28961065587;47578.76210618925;47652.761736191096;47660.76169619129;1056.6565866093551;1077.8383242513685;1084.0243780597368;1143.3997151495364;1189.637160665988;26655.866720666272;28077;29481;30624.693753062184;30676.84661576678;44085.77957110194;44619.330710038725;44648.33027504525;44769.552304476536;44793.552064478936;334470;336268;336507;336793;338400;24368.51262974766;24459.87770061138;24881.253562393158;25038.37404064913;25110.37224069413;39844;39905.401418979316;40805.79597101996;41140.382894256014;41244.38133427941;33554.83222583871;34110.829445852614;34613.480797787546;34623.82688086543;35122.64877351194;33644.327113457104;34451.4832277511;34600.82699586486;34619.48070778991;34768.437050071865;33400.83299583486;33415.83292083524;33580;33985.66014339924;34315.14212144716;29322.56016159802;31154.22114447157;31193.53209701811;31329.373412531168;31908.521372178973;24555.63166552539;24913.50172996566;24975.000999960524;25171.496570068863;25197.622035669112 09:04:31 INFO - PROCESS | 6233 | |2;jquery.html;337.81251405469953;356.1985532551757;357.3728107171914;367.2984599415116;385.25260993672276;12292.508299668014;13113.868861311385;15538.456154034611;16225.51323460298;16548;15877.603059923507;16745.581360465996;16753.413630522933;16937.491875243733;17090.401835935743;4674.509176536466;4822.156122678535;4920.409550853894;5163.870903227412;5167.767450464719;4968.900621987558;5106.085218043234;5109.054824857395;5112.0287145442435;5121.180611102224;4878.829240976566;5066.138756411419;5074.822381216658;5076.6700164489375;5077;4785.832495862645;5039.84880453587;5049.545540901318;5049.697018178903;5049.823256186016;4357.891052723676;4545.772711364419;4546.045330480603;4546.772661366918;4554.590086892195;19933.601327973505;20015;20107.597848043104;20144.294949676692;20167.991600420068;1764.1884733022825;1905.3902751119647;1920.4718702356963;1942.4561122885473;2426.0780903256828;7515.962420187919;13271.469141234338;13324.400401981935;13582.864171358258;13624;1667.7998640163137;1681.2770508681263;1706.9231884565224;1707.9743803842953;1747.4058820001133;65243.3475665242;65786.3421365785;66243.33756662419;66298;67051;9245.768855778659;9280.118388753057;9549.952250238843;9682.854757178648;9693;13246.139000964906;13256.138351007154;13279.074534192488;13279.277748061624;13286.402111904987;6586.80239592813;6857.182846545669;6982.067531636725;6996.160460744743;7034.6834392452465;6390.392912673288;6393.200849893763;6394.776182833579;6525.543211975211;6562.606243625398;5895.41045895407;5935.614185077956;5954.970225148933;6024.7106099682715;6043.425874541911;1705.5821323775506;1714.297138173343;1723.2073246306588;1737.5916659584987;1799.6490684316432;751.9699212031458;838.6100463284602;909.8999110097884;913.5474595393356;939.3283802081545;15644;15729.752966698927;15843.524694259191;16702.4154154604;17706.734398984026;819.2381085590458;857.935654825878;858.0689951402674;867.4058270085012;882.1178821178821;9441;10129.139023182965;10151.289409741396;10168.135708464715;10319.329243599143;382606;383118;387957;392299;395838;80173.59913200514;83062;84043;84362.5781871099;84893;894.0344428017595;895.8477058900003;943.6508491857919;944.2493217891792;951.2295041016798;15358.394186122208;15373.154476503452;16092.919535402249;16419.67160656804;16445.835541644432;24936;29071.418571628026;29798.702012979593;34715.30569388648;36541;48050.519494804605;49324;49809.50190498048;50071.49928500814;50507.24239136343;6563.212414510289;7008.159020917523;7160.462965277521;7326.4138868889295;7425.628718564159;10065.477083020884;11139.610113645984;11682.94158529202;12163.635090947286;12276.508939642672;9689.951550242204;9859.309848310837;10414.271001030158;10670.413127278074;10993.856198041305;10168.33905796121;10380.221483388625;10492.580296788348;10627.734306642087;10887.020168184901;10298.639547616098;10301.639442619473;10344.534495947852;10658.253922225369;11098.167637427387;7015.894761578683;7105.360517553445;7116.857662846611;7207.891881621885;7222.09723784527;8792;10504.10715089226;10549.736256593647;10552.155827533625;10901.310296903992 09:04:31 INFO - PROCESS | 6233 | |3;mootools.html;1229.9139060265784;1309.135970259629;1356.9864301356986;1375.6560859785054;1660.8837381383294;6471.158749362582;7025.894611580824;7235.348818606331;7533.811654708635;7536.397088232942;7589.241075892408;7655.655495502702;7662.233776622335;7665.770026899188;7668.348190403808;2076.5743022680354;2084.551821358408;2096.842736794739;2102.3797979596056;2109.261758384561;1988.5128143604836;2033.9593208135827;2040.3776848061336;2060.701198326249;2076.9376918692387;2072.761632412269;2088.321295578943;2090.5400811821373;2095.067694875781;2097.4441772930186;2020.0202901592716;2026.4629873083645;2032.8475364347732;2038.0930485933766;2040.9183632654676;1967.5868067705799;2004.5790384019374;2005.9398218053482;2012.4465771912694;2022.1506967073865;7450.701971921117;7500.399968002546;7582.772516824504;7590.658420371096;7603;4212.241796476633;4374.934375984363;4376.5623437656295;4433.246348120827;4434.711743736679;2619.7773189278932;2713.9592906106423;2743.890244390222;2765.363966287745;2767.045369347592;807.6648191000728;818.6152508321079;822.0998007182126;822.9588520574007;849.7110982265997;9669.468179250138;9746.26902982272;9781;9803.362781419184;9804.754881127958;3554.0581745837376;3589.5333606631493;3716.7398282119993;3806.847726090981;3835.846566137379;7749.4575379724;7759.68961241544;7761.301482866569;7761.883571746428;7773.261540153676;4103.5691252418665;4108.157827645326;4108.979455102765;4110.445089912883;4111.177764447063;3444.5522082129664;3570.6072332043454;3783.243351329745;3793.886183414502;3834.9616503834604;3145.150809281481;3186.267158553546;3282.3107147498813;3304.289577740797;3306.272620023591;933.2254228989922;941.110650435332;941.9105185007413;943.2785167070125;948.3835506920419;773.4122067228834;784.1491981200461;787.1577412169039;797.1589972578869;804.8631732605471;4661.440627124767;4829.372181616367;4844.491328410537;4858.198397264482;5009.0983622948215;836.9832603347899;845.691322667222;846.6147902704378;849.5497386385226;859.2266959736287;3311.718503927145;3352.6479719629087;3370.8483118259737;3417.6411476795074;3475.808830514346;8682.262007729414;9180.357374983687;9180.403273787182;9186.86219706705;9190.035046320174;8986.236169925498;9130;9223.308251881135;9253.352265341497;9300.581473833694;6797.218319893275;6917.239103698589;6923.446124310043;6928.792136235921;6930.514863959575;4810.783514741915;4833.468318484894;4913.6069114471475;4939.308496810521;4981.128302547112;7817.218278172138;8193.877091843508;8201.466904651179;8264.586770661323;8298.626561804613;8368.24685778283;8369.121242269473;8374.748757537283;8384.958075209584;8667.17661822126;5886.852828679317;6469.4824414045825;6613.404793568602;6618;6618.1065556151225;6634.767783127568;6834.555753875982;7075.71697132109;7135.286471352823;7278.053852999288;6223.159873417031;6322.810315690536;6630.3038180992235;6658.300878407697;6764.695588698619;6575.638339891352;6606.372394622503;6616;6632.436242919406;6650.800475985729;5927.436893495111;6007.068904319663;6009.128676341818;6011.338752737282;6027.246594175728;4289.7640629765665;4346.934795978;4373.2128216921255;4406.845760398371;4456.665750068693;4355.368471571541;4374.606285434326;4454.376387305844;4467.553244675506;4516.728996260234 09:04:31 INFO - PROCESS | 6233 | |4;prototype.html;283.74888223921835;286.55869960261197;290.76302813207235;293.6608217508778;299.19068918575255;4874.415070191578;4894.510548945103;4899.510048995103;4908.312836202935;4916.459189489154;4772.8090876364995;4775.976120119394;4798.856034318976;4863.392075990501;4877.3903262092235;3527.259275552131;3619.3123306571665;3639.126609613687;3692.686121679647;3765.5293088363956;3750.737448378601;3774.9622503774885;3776.5090538229992;3784.7161462890253;3816.7709937403706;3737.084414318496;3745.7003439724895;3748.0697440818;3773.8301776420126;3788.5074940257864;3570.410882204433;3597.892063238107;3692.332269965617;3723.8510459581585;3733.3653278942643;3270.8201048942296;3271.362084393544;3279.475283954556;3281.606207255121;3285.769996100274;4686.53134686532;4687.7108795081285;4689.671722979393;4691;4722.433308003027;4179.185058913513;4265.317549192115;4274.636655884254;4302.569743025703;4316.611504964569;4960.950390496085;4963.106640804654;4969.055879382906;4977.527134922177;5006.148954677714;3629.8366573504254;3630.8547658093644;3635.8182090895616;3649.197176621139;3651.269746050774;5003.574696150831;5261.3686357637325;5280.471952804689;5305.726625609865;5316.867078323035;3533.982330088333;3534.896736441813;3539.3275277697153;3552.5914519830035;3566.928661426809;3577.2130131371055;3577.4276115821344;3583.802890841029;3604.3151801157696;3606.2967721294094;4156.709030367845;4158.521769996429;4159.209750147463;4160.251154792167;4161.188568229227;4845.224764037807;5014.623903207274;5048.671836330626;5081.780372710597;5101.540861322499;1292.9979266068683;1299.493197652916;1303.9503199924152;1304.6738315421144;1307.1372893889986;795.4431897671653;829.5354601423222;833.3125171733344;843.304273973974;849.8017794909149;4268.423762792046;4391.253486907233;4434.889127771831;4511.4886513017855;4515.841945531956;5185.948140518622;5197.7141257231215;5208.322918020633;5241.9213711794355;5253.89668169681;4485.977570112129;4490.865274041784;4508.301213311942;4516.728996260234;4548.658850586219;2614.9215523534326;2727.990643461932;2729.549624312006;2756.9035083771973;2757.131503576367;4875.902481950341;4883.780229889663;4911.263310503453;4912.631552633496;4927.852164435073;5114.667546609458;5353.197020446964;5356.223347614574;5362.490563396471;5405.324334458192;4844.709317440965;4850.9085455772165;4853.611711063107;4902.583280421204;4936.185529387611;5179.1195496764885;5181.3005244291535;5188.844334669966;5199.220116982483;5292.655977361459;4941.456439791692;5084.923726144037;5161.587073034223;5164.302819119371;5177.870553236199;4866.1046677227;4889.755512224303;4890.657653964331;4902.656814023127;4932.728699921395;3705.314516814398;3709.5919448860063;3717.1450566369344;3739.2521495701512;3760.962390376171;4917.606591472602;5184.911168654625;5187.559057480156;5198.8960220796125;5200.2199670049795;4978.800847966186;4986.32684587576;4993.975030124826;4998.725070121178;5026.246063090565;4995.350604421402;4995.400551933792;4999.300097986212;5087.491250874883;5093.2105523643895;4689.929651055305;4938.629602779734;4946.901061978669;4979.526944940225;4986.775595098156;4851.2723091535145;4974.477679843564;5084.872878178076;5095.363079615048;5120.641555091108;4831.236598641541;4948.455669876239;4977.208205046108;4982.533645845329;4990.707991127555 09:04:31 INFO - PROCESS | 6233 | |5;yui.html;617.802303262956;617.9969100154499;637.1875858280695;695.4957655699617;706.554870431628;13117.934410327947;13795.034347595672;13800.930995345021;13807.102538335013;13819;13128.474861005572;13139.474421023147;13147.145435546683;13161.868381316208;13166.144200626977;613.175279249411;631.0691729698681;737.6164394514876;748.8839229919371;764.9847003059936;765.4871236271683;767.4052609227865;768.174212721324;768.5734417398342;768.6348984232501;811.9472234304751;812.1229072601576;813.8453693798189;814.42989907065;815.1278132398336;635.3075148088583;657.8486948001986;658.8748137853793;662.3906006474056;810.8621534339177;489.3955964383983;570.7431655754926;583.8306891001605;585.9384764599741;590.9290885093774;12400.627981160489;12424.627261182179;12439.129260951737;12448.439820208112;12449.626511204679;11753.88246117545;12034.157608967376;12163.817542736866;12489.875101248963;12638.004935705903;10362.430066346347;10471.062988193466;10541.894581054168;10567.68296951085;10657.680269591925;3789.4315852622053;3804.3912973924316;3810.923781524382;3815.2178803345246;3877.6316249956208;60060.39939600635;60597;61590.69204653948;62109.689451552455;63211.051834222526;9059.728208153765;9071.546422678839;9293.070692930789;9305.022972587916;9389;18514.351997680016;18553.35063272779;18602.162902669414;18641.53396165107;18661.81338186628;6493.935060649427;6520.967395163088;6521.739130434729;6552.213734351813;6555.475561955032;3402.625711171769;3590.2281009583066;3648.1791596891017;3661.56061272649;3670.302642497917;2726.700062993069;2780.165950214968;2806.9017584384446;2812.73279038491;2814.3808362160294;481.3670023918536;491.77132633325675;497.6392115716077;502.7988804478238;504.09011733820074;446.67283453209143;500.279597379772;539.3339226055818;543.2665901033573;546.8468828727963;6821.1814582250445;7135.215126336099;7436.776896693108;7479.887801682979;7640.885386719204;454.7521600727611;503.6147347279334;525.1571228178794;533.5704757670113;565.0761005755619;3375.8818441354433;3459.3600183965546;3584.8386822593047;3666.3400587893902;3855.575886652466;94207.52896235474;95148.52425737827;95892;98220.50889745649;102860.48569757103;63907.680461597396;64708.35291647117;88261;90171;91241;59028.40971590315;64954.35045649578;69124.65437672779;70169.29830701627;70405.64797175981;8156.714514991947;8507.95746021266;8544.786380340542;8754.952910021377;8764.956175219084;36262;37258;37773.24453510969;38279.42580861345;42345;37534.43698344582;38538;45793.54206457893;59165.704171478865;59990.10014849693;10676.83984740245;11170.218084733991;11295.039921606756;11328;11554.653360399201;12512.186707863959;12628.621141365773;12812.55156069533;13448.462061517821;13689.452421903012;10907.454627268446;11098.944505277423;11388.829167562659;11480.253783504046;11688.649340519798;11511.251768635011;12248.448819803309;12250.448729807002;12526.185797923106;12791.936040319739;11091.5563377464;11561.190716649753;11581.942090289831;11600.213341840517;11950.282983021047;8735.825283494421;8898.777530561787;9159.908400916172;9908.166989107038;10003.599856005969;9396.76508087276;10012.64955726546;10136.847947280945;10140.797184056426;10152.39085654863 09:04:31 INFO - PROCESS | 6233 | __end_tp_report 09:04:31 INFO - PROCESS | 6233 | __start_cc_report 09:04:31 INFO - PROCESS | 6233 | _x_x_mozilla_cycle_collect,1154 09:04:31 INFO - PROCESS | 6233 | __end_cc_report 09:04:31 INFO - PROCESS | 6233 | __startTimestamp1475597071810__endTimestamp 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | ------- Summary: start ------- 09:04:31 INFO - PROCESS | 6233 | Number of tests: 6 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#0] dojo.html Cycles:165 Average:4627.84 Median:4754.38 stddev:479.57 (10.1%) stddev-sans-first:452.98 09:04:31 INFO - PROCESS | 6233 | Values: 2567.2 2590.3 2631.2 2631.8 2651.2 4573.8 4611.1 4729.3 4729.5 4754.4 4663.5 4674.8 4715.5 4730.4 4804.8 4229.8 4250.6 4275.3 4363.0 4388.4 4312.7 4313.6 4364.2 4381.8 4422.7 4404.6 4411.4 4420.7 4457.5 4466.1 4220.8 4237.7 4241.1 4302.5 4335.3 4304.2 4305.2 4382.7 4390.9 4391.8 4686.7 4718.3 4724.2 4732.6 4785.2 4915.1 5057.2 5059.8 5061.1 5122.3 4912.3 4948.6 4963.7 4989.0 5017.3 4629.9 4633.2 4634.3 4636.5 4681.7 5062.3 5062.8 5062.8 5068.2 5127.1 4801.6 4850.3 4913.7 4941.2 4970.9 5047.7 5052.6 5056.5 5060.4 5108.0 4977.7 4986.5 5012.0 5033.1 5046.8 4765.6 4767.4 4817.9 4853.4 4975.0 4158.0 4198.4 4198.8 4232.4 4248.2 3655.6 3659.9 3663.8 3698.9 3703.7 4266.7 4322.6 4328.0 4339.7 4364.3 5001.9 5041.5 5046.4 5070.7 5118.2 4353.8 4362.2 4374.6 4379.4 4426.4 4396.3 4554.5 4556.0 4556.1 4586.7 4651.5 4702.4 4730.4 4755.3 4783.4 5042.8 5057.5 5059.2 5067.5 5117.5 4725.5 4736.9 4746.9 4748.1 4807.2 4814.3 4829.3 4842.5 4859.2 4885.5 4921.5 4931.9 4939.6 4940.0 4999.4 4818.0 4826.9 4834.2 4852.6 4890.9 4734.1 4778.7 4840.0 4848.2 4874.5 4839.5 4850.1 4862.6 4879.0 4896.8 4793.6 4914.3 4945.9 4955.3 5019.2 4718.3 4726.9 4775.6 4790.9 4804.2 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#1] ext.html Cycles:180 Average:45661.30 Median:34945.54 stddev:85750.41 (245.4%) stddev-sans-first:85924.04 09:04:31 INFO - PROCESS | 6233 | Values: 539.9 547.8 551.9 567.9 569.8 26958.9 37620.2 38869.4 38873.6 42158.0 39320.8 39726.6 39793.2 40013.2 40105.4 7638.1 7784.7 7788.6 7789.6 7792.9 7649.8 7732.4 7767.7 7772.1 7774.7 7784.5 7805.6 7833.5 7835.4 7837.8 7720.1 7727.2 7736.2 7744.0 7760.3 7655.7 7714.6 7728.0 7738.5 7738.5 37131.4 37427.4 37427.8 37472.1 37489.3 2922.1 2937.8 3030.1 3181.4 3190.9 26899.3 27369.6 27389.0 27783.7 28055.9 3313.3 3329.5 3350.2 3386.9 3422.9 239533.0 240228.0 240253.0 241153.0 241594.0 30642.4 48374.0 48691.3 48779.0 48817.0 31222.4 32292.8 32337.2 32338.4 32350.5 12267.6 12476.6 12485.9 12488.0 12497.4 9378.9 9462.2 9475.3 9477.1 9481.7 7279.6 7479.1 7516.8 7526.7 7536.2 2885.4 2901.3 2942.9 2961.5 2985.3 827.6 852.2 877.8 912.3 969.5 26415.3 26940.9 27258.3 27373.0 27579.0 761.9 924.4 947.1 958.7 986.4 13262.9 14345.4 14432.4 14462.6 14491.5 378015.1 380849.0 381000.0 381096.0 382677.0 47126.8 47359.3 47578.8 47652.8 47660.8 1056.7 1077.8 1084.0 1143.4 1189.6 26655.9 28077.0 29481.0 30624.7 30676.8 44085.8 44619.3 44648.3 44769.6 44793.6 334470.0 336268.0 336507.0 336793.0 338400.0 24368.5 24459.9 24881.3 25038.4 25110.4 39844.0 39905.4 40805.8 41140.4 41244.4 33554.8 34110.8 34613.5 34623.8 35122.6 33644.3 34451.5 34600.8 34619.5 34768.4 33400.8 33415.8 33580.0 33985.7 34315.1 29322.6 31154.2 31193.5 31329.4 31908.5 24555.6 24913.5 24975.0 25171.5 25197.6 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#2] jquery.html Cycles:180 Average:24079.23 Median:4451.83 stddev:64210.48 (1442.3%) stddev-sans-first:64365.86 09:04:31 INFO - PROCESS | 6233 | Values: 337.8 356.2 357.4 367.3 385.3 12292.5 13113.9 15538.5 16225.5 16548.0 15877.6 16745.6 16753.4 16937.5 17090.4 4674.5 4822.2 4920.4 5163.9 5167.8 4968.9 5106.1 5109.1 5112.0 5121.2 4878.8 5066.1 5074.8 5076.7 5077.0 4785.8 5039.8 5049.5 5049.7 5049.8 4357.9 4545.8 4546.0 4546.8 4554.6 19933.6 20015.0 20107.6 20144.3 20168.0 1764.2 1905.4 1920.5 1942.5 2426.1 7516.0 13271.5 13324.4 13582.9 13624.0 1667.8 1681.3 1706.9 1708.0 1747.4 65243.3 65786.3 66243.3 66298.0 67051.0 9245.8 9280.1 9550.0 9682.9 9693.0 13246.1 13256.1 13279.1 13279.3 13286.4 6586.8 6857.2 6982.1 6996.2 7034.7 6390.4 6393.2 6394.8 6525.5 6562.6 5895.4 5935.6 5955.0 6024.7 6043.4 1705.6 1714.3 1723.2 1737.6 1799.6 752.0 838.6 909.9 913.5 939.3 15644.0 15729.8 15843.5 16702.4 17706.7 819.2 857.9 858.1 867.4 882.1 9441.0 10129.1 10151.3 10168.1 10319.3 382606.0 383118.0 387957.0 392299.0 395838.0 80173.6 83062.0 84043.0 84362.6 84893.0 894.0 895.8 943.7 944.2 951.2 15358.4 15373.2 16092.9 16419.7 16445.8 24936.0 29071.4 29798.7 34715.3 36541.0 48050.5 49324.0 49809.5 50071.5 50507.2 6563.2 7008.2 7160.5 7326.4 7425.6 10065.5 11139.6 11682.9 12163.6 12276.5 9690.0 9859.3 10414.3 10670.4 10993.9 10168.3 10380.2 10492.6 10627.7 10887.0 10298.6 10301.6 10344.5 10658.3 11098.2 7015.9 7105.4 7116.9 7207.9 7222.1 8792.0 10504.1 10549.7 10552.2 10901.3 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#3] mootools.html Cycles:180 Average:4805.45 Median:6125.20 stddev:2698.67 (44.1%) stddev-sans-first:2692.86 09:04:31 INFO - PROCESS | 6233 | Values: 1229.9 1309.1 1357.0 1375.7 1660.9 6471.2 7025.9 7235.3 7533.8 7536.4 7589.2 7655.7 7662.2 7665.8 7668.3 2076.6 2084.6 2096.8 2102.4 2109.3 1988.5 2034.0 2040.4 2060.7 2076.9 2072.8 2088.3 2090.5 2095.1 2097.4 2020.0 2026.5 2032.8 2038.1 2040.9 1967.6 2004.6 2005.9 2012.4 2022.2 7450.7 7500.4 7582.8 7590.7 7603.0 4212.2 4374.9 4376.6 4433.2 4434.7 2619.8 2714.0 2743.9 2765.4 2767.0 807.7 818.6 822.1 823.0 849.7 9669.5 9746.3 9781.0 9803.4 9804.8 3554.1 3589.5 3716.7 3806.8 3835.8 7749.5 7759.7 7761.3 7761.9 7773.3 4103.6 4108.2 4109.0 4110.4 4111.2 3444.6 3570.6 3783.2 3793.9 3835.0 3145.2 3186.3 3282.3 3304.3 3306.3 933.2 941.1 941.9 943.3 948.4 773.4 784.1 787.2 797.2 804.9 4661.4 4829.4 4844.5 4858.2 5009.1 837.0 845.7 846.6 849.5 859.2 3311.7 3352.6 3370.8 3417.6 3475.8 8682.3 9180.4 9180.4 9186.9 9190.0 8986.2 9130.0 9223.3 9253.4 9300.6 6797.2 6917.2 6923.4 6928.8 6930.5 4810.8 4833.5 4913.6 4939.3 4981.1 7817.2 8193.9 8201.5 8264.6 8298.6 8368.2 8369.1 8374.7 8385.0 8667.2 5886.9 6469.5 6613.4 6618.0 6618.1 6634.8 6834.6 7075.7 7135.3 7278.1 6223.2 6322.8 6630.3 6658.3 6764.7 6575.6 6606.4 6616.0 6632.4 6650.8 5927.4 6007.1 6009.1 6011.3 6027.2 4289.8 4346.9 4373.2 4406.8 4456.7 4355.4 4374.6 4454.4 4467.6 4516.7 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#4] prototype.html Cycles:180 Average:4176.28 Median:4844.97 stddev:1223.60 (25.3%) stddev-sans-first:1191.65 09:04:31 INFO - PROCESS | 6233 | Values: 283.7 286.6 290.8 293.7 299.2 4874.4 4894.5 4899.5 4908.3 4916.5 4772.8 4776.0 4798.9 4863.4 4877.4 3527.3 3619.3 3639.1 3692.7 3765.5 3750.7 3775.0 3776.5 3784.7 3816.8 3737.1 3745.7 3748.1 3773.8 3788.5 3570.4 3597.9 3692.3 3723.9 3733.4 3270.8 3271.4 3279.5 3281.6 3285.8 4686.5 4687.7 4689.7 4691.0 4722.4 4179.2 4265.3 4274.6 4302.6 4316.6 4961.0 4963.1 4969.1 4977.5 5006.1 3629.8 3630.9 3635.8 3649.2 3651.3 5003.6 5261.4 5280.5 5305.7 5316.9 3534.0 3534.9 3539.3 3552.6 3566.9 3577.2 3577.4 3583.8 3604.3 3606.3 4156.7 4158.5 4159.2 4160.3 4161.2 4845.2 5014.6 5048.7 5081.8 5101.5 1293.0 1299.5 1304.0 1304.7 1307.1 795.4 829.5 833.3 843.3 849.8 4268.4 4391.3 4434.9 4511.5 4515.8 5185.9 5197.7 5208.3 5241.9 5253.9 4486.0 4490.9 4508.3 4516.7 4548.7 2614.9 2728.0 2729.5 2756.9 2757.1 4875.9 4883.8 4911.3 4912.6 4927.9 5114.7 5353.2 5356.2 5362.5 5405.3 4844.7 4850.9 4853.6 4902.6 4936.2 5179.1 5181.3 5188.8 5199.2 5292.7 4941.5 5084.9 5161.6 5164.3 5177.9 4866.1 4889.8 4890.7 4902.7 4932.7 3705.3 3709.6 3717.1 3739.3 3761.0 4917.6 5184.9 5187.6 5198.9 5200.2 4978.8 4986.3 4994.0 4998.7 5026.2 4995.4 4995.4 4999.3 5087.5 5093.2 4689.9 4938.6 4946.9 4979.5 4986.8 4851.3 4974.5 5084.9 5095.4 5120.6 4831.2 4948.5 4977.2 4982.5 4990.7 09:04:31 INFO - PROCESS | 6233 | 09:04:31 INFO - PROCESS | 6233 | [#5] yui.html Cycles:180 Average:16725.36 Median:23137.45 stddev:23857.93 (103.1%) stddev-sans-first:23894.21 09:04:31 INFO - PROCESS | 6233 | Values: 617.8 618.0 637.2 695.5 706.6 13117.9 13795.0 13800.9 13807.1 13819.0 13128.5 13139.5 13147.1 13161.9 13166.1 613.2 631.1 737.6 748.9 765.0 765.5 767.4 768.2 768.6 768.6 811.9 812.1 813.8 814.4 815.1 635.3 657.8 658.9 662.4 810.9 489.4 570.7 583.8 585.9 590.9 12400.6 12424.6 12439.1 12448.4 12449.6 11753.9 12034.2 12163.8 12489.9 12638.0 10362.4 10471.1 10541.9 10567.7 10657.7 3789.4 3804.4 3810.9 3815.2 3877.6 60060.4 60597.0 61590.7 62109.7 63211.1 9059.7 9071.5 9293.1 9305.0 9389.0 18514.4 18553.4 18602.2 18641.5 18661.8 6493.9 6521.0 6521.7 6552.2 6555.5 3402.6 3590.2 3648.2 3661.6 3670.3 2726.7 2780.2 2806.9 2812.7 2814.4 481.4 491.8 497.6 502.8 504.1 446.7 500.3 539.3 543.3 546.8 6821.2 7135.2 7436.8 7479.9 7640.9 454.8 503.6 525.2 533.6 565.1 3375.9 3459.4 3584.8 3666.3 3855.6 94207.5 95148.5 95892.0 98220.5 102860.5 63907.7 64708.4 88261.0 90171.0 91241.0 59028.4 64954.4 69124.7 70169.3 70405.6 8156.7 8508.0 8544.8 8755.0 8765.0 36262.0 37258.0 37773.2 38279.4 42345.0 37534.4 38538.0 45793.5 59165.7 59990.1 10676.8 11170.2 11295.0 11328.0 11554.7 12512.2 12628.6 12812.6 13448.5 13689.5 10907.5 11098.9 11388.8 11480.3 11688.6 11511.3 12248.4 12250.4 12526.2 12791.9 11091.6 11561.2 11581.9 11600.2 11950.3 8735.8 8898.8 9159.9 9908.2 10003.6 9396.8 10012.6 10136.8 10140.8 10152.4 09:04:31 INFO - PROCESS | 6233 | -------- Summary: end -------- 09:04:31 INFO - PROCESS | 6233 | 09:04:32 INFO - TEST-INFO | 6233: exit 0 09:04:32 INFO - TEST-OK | dromaeo_css | took 1121550ms 09:04:32 INFO - TEST-START | kraken 09:04:32 INFO - operating with platform_type : linux_ 09:04:32 INFO - Initialising browser for kraken test... 09:04:32 INFO - TEST-INFO | started process 6539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmGZI8/profile http://localhost:39343/getInfo.html) 09:04:37 INFO - PROCESS | 6539 | __metrics Screen width/height:1600/1200 09:04:37 INFO - PROCESS | 6539 | colorDepth:24 09:04:37 INFO - PROCESS | 6539 | Browser inner width/height: 1024/697 09:04:37 INFO - PROCESS | 6539 | __metrics 09:04:37 INFO - PROCESS | 6539 | 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" 09:04:37 INFO - PROCESS | 6539 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:38 INFO - PROCESS | 6539 | console.error: PushService: 09:04:38 INFO - PROCESS | 6539 | stateChangeProcessEnqueue: Error transitioning state 09:04:38 INFO - PROCESS | 6539 | UnknownError 09:04:39 INFO - TEST-INFO | 6539: exit 0 09:04:39 INFO - Browser initialized. 09:04:39 INFO - Running cycle 1/1 for kraken test... 09:04:39 INFO - TEST-INFO | started process 6619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkmGZI8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:51 INFO - PROCESS | 6619 | RSS: Main: 175489024 09:04:51 INFO - PROCESS | 6619 | 09:04:54 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39343/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:55 INFO - PROCESS | 6619 | RSS: Main: 233902080 09:04:55 INFO - PROCESS | 6619 | 09:04:57 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39343/tests/kraken/driver.html?testName=audio-dft) 09:04:58 INFO - PROCESS | 6619 | RSS: Main: 218877952 09:04:58 INFO - PROCESS | 6619 | 09:05:01 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39343/tests/kraken/driver.html?testName=audio-fft) 09:05:02 INFO - PROCESS | 6619 | RSS: Main: 301170688 09:05:02 INFO - PROCESS | 6619 | 09:05:04 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39343/tests/kraken/driver.html?testName=audio-oscillator) 09:05:05 INFO - PROCESS | 6619 | RSS: Main: 211992576 09:05:05 INFO - PROCESS | 6619 | 09:05:07 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:08 INFO - PROCESS | 6619 | RSS: Main: 214679552 09:05:08 INFO - PROCESS | 6619 | 09:05:11 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39343/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:11 INFO - PROCESS | 6619 | RSS: Main: 250699776 09:05:11 INFO - PROCESS | 6619 | 09:05:15 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39343/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:15 INFO - PROCESS | 6619 | RSS: Main: 244465664 09:05:15 INFO - PROCESS | 6619 | 09:05:18 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39343/tests/kraken/driver.html?testName=json-parse-financial) 09:05:19 INFO - PROCESS | 6619 | RSS: Main: 247332864 09:05:19 INFO - PROCESS | 6619 | 09:05:21 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:21 INFO - PROCESS | 6619 | RSS: Main: 211447808 09:05:21 INFO - PROCESS | 6619 | 09:05:23 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:24 INFO - PROCESS | 6619 | RSS: Main: 218046464 09:05:24 INFO - PROCESS | 6619 | 09:05:26 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:27 INFO - PROCESS | 6619 | RSS: Main: 228220928 09:05:27 INFO - PROCESS | 6619 | 09:05:30 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:30 INFO - PROCESS | 6619 | RSS: Main: 236630016 09:05:30 INFO - PROCESS | 6619 | 09:05:33 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:34 INFO - PROCESS | 6619 | RSS: Main: 232554496 09:05:34 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | Cycle 1(1): loaded http://localhost:39343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39343/tests/kraken/driver.html?testName=ai-astar) 09:05:36 INFO - PROCESS | 6619 | RSS: Main: 283688960 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | __start_tp_report 09:05:36 INFO - PROCESS | 6619 | _x_x_mozilla_page_load 09:05:36 INFO - PROCESS | 6619 | _x_x_mozilla_page_load_details 09:05:36 INFO - PROCESS | 6619 | |i|pagename|runs| 09:05:36 INFO - PROCESS | 6619 | |0;ai-astar;112;116;115;115;114;114;114;116;115;115 09:05:36 INFO - PROCESS | 6619 | |1;audio-beat-detection;156;132;129;187;126;128;127;134;179;127 09:05:36 INFO - PROCESS | 6619 | |2;audio-dft;161;161;163;160;160;160;162;161;163;162 09:05:36 INFO - PROCESS | 6619 | |3;audio-fft;75;77;76;110;76;76;76;75;99;75 09:05:36 INFO - PROCESS | 6619 | |4;audio-oscillator;93;82;120;83;83;84;109;83;83;118 09:05:36 INFO - PROCESS | 6619 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;117 09:05:36 INFO - PROCESS | 6619 | |6;imaging-darkroom;148;147;146;147;147;147;147;146;147;148 09:05:36 INFO - PROCESS | 6619 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;95;95 09:05:36 INFO - PROCESS | 6619 | |8;json-parse-financial;65;63;63;63;65;64;65;63;64;66 09:05:36 INFO - PROCESS | 6619 | |9;json-stringify-tinderbox;66;66;66;68;65;66;66;67;66;67 09:05:36 INFO - PROCESS | 6619 | |10;stanford-crypto-aes;84;93;87;94;84;84;99;84;84;92 09:05:36 INFO - PROCESS | 6619 | |11;stanford-crypto-ccm;142;141;149;139;150;141;141;140;174;143 09:05:36 INFO - PROCESS | 6619 | |12;stanford-crypto-pbkdf2;177;190;177;183;180;181;177;176;177;178 09:05:36 INFO - PROCESS | 6619 | |13;stanford-crypto-sha256-iterative;71;70;70;72;74;75;73;70;70;79 09:05:36 INFO - PROCESS | 6619 | __end_tp_report 09:05:36 INFO - PROCESS | 6619 | __start_cc_report 09:05:36 INFO - PROCESS | 6619 | _x_x_mozilla_cycle_collect,1941 09:05:36 INFO - PROCESS | 6619 | __end_cc_report 09:05:36 INFO - PROCESS | 6619 | __startTimestamp1475597136459__endTimestamp 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | ------- Summary: start ------- 09:05:36 INFO - PROCESS | 6619 | Number of tests: 14 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.17 (1.0%) stddev-sans-first:0.78 09:05:36 INFO - PROCESS | 6619 | Values: 112.0 116.0 115.0 115.0 114.0 114.0 114.0 116.0 115.0 115.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#1] audio-beat-detection Cycles:10 Average:142.50 Median:133.00 stddev:23.15 (17.4%) stddev-sans-first:24.03 09:05:36 INFO - PROCESS | 6619 | Values: 156.0 132.0 129.0 187.0 126.0 128.0 127.0 134.0 179.0 127.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:1.16 (0.7%) stddev-sans-first:1.22 09:05:36 INFO - PROCESS | 6619 | Values: 161.0 161.0 163.0 160.0 160.0 160.0 162.0 161.0 163.0 162.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:12.41 (16.3%) stddev-sans-first:12.94 09:05:36 INFO - PROCESS | 6619 | Values: 75.0 77.0 76.0 110.0 76.0 76.0 76.0 75.0 99.0 75.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:83.00 stddev:15.65 (18.9%) stddev-sans-first:16.60 09:05:36 INFO - PROCESS | 6619 | Values: 93.0 82.0 120.0 83.0 83.0 84.0 109.0 83.0 83.0 118.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:05:36 INFO - PROCESS | 6619 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 09:05:36 INFO - PROCESS | 6619 | Values: 148.0 147.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 148.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:05:36 INFO - PROCESS | 6619 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:64.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 09:05:36 INFO - PROCESS | 6619 | Values: 65.0 63.0 63.0 63.0 65.0 64.0 65.0 63.0 64.0 66.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 09:05:36 INFO - PROCESS | 6619 | Values: 66.0 66.0 66.0 68.0 65.0 66.0 66.0 67.0 66.0 67.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.50 stddev:5.54 (6.2%) stddev-sans-first:5.63 09:05:36 INFO - PROCESS | 6619 | Values: 84.0 93.0 87.0 94.0 84.0 84.0 99.0 84.0 84.0 92.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#11] stanford-crypto-ccm Cycles:10 Average:146.00 Median:142.50 stddev:10.51 (7.4%) stddev-sans-first:11.05 09:05:36 INFO - PROCESS | 6619 | Values: 142.0 141.0 149.0 139.0 150.0 141.0 141.0 140.0 174.0 143.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:179.00 stddev:4.27 (2.4%) stddev-sans-first:4.43 09:05:36 INFO - PROCESS | 6619 | Values: 177.0 190.0 177.0 183.0 180.0 181.0 177.0 176.0 177.0 178.0 09:05:36 INFO - PROCESS | 6619 | 09:05:36 INFO - PROCESS | 6619 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:72.50 stddev:2.95 (4.1%) stddev-sans-first:3.09 09:05:36 INFO - PROCESS | 6619 | Values: 71.0 70.0 70.0 72.0 74.0 75.0 73.0 70.0 70.0 79.0 09:05:36 INFO - PROCESS | 6619 | -------- Summary: end -------- 09:05:36 INFO - PROCESS | 6619 | 09:05:37 INFO - TEST-INFO | 6619: exit 0 09:05:37 INFO - TEST-OK | kraken | took 64860ms 09:05:37 INFO - SUITE-END | took 1186s 09:05:38 INFO - Completed test suite (00:19:46) 09:05:38 INFO - javascript benchmark 09:05:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2567.2041667083204, 2590.326515106072, 2631.2106368089567, 2631.842089474632, 2651.164883061834, 4573.8399156029545, 4611.1469378164975, 4729.266963620636, 4729.527047295269, 4754.38193034905, 4663.48701642819, 4674.813007479705, 4715.528447155283, 4730.3614012108355, 4804.83183088592, 4229.7885105744745, 4250.61744443, 4275.315949448089, 4363.040131171138, 4388.385626012361, 4312.654987600984, 4313.633341166004, 4364.192624364487, 4381.824727010931, 4422.7346359218545, 4404.581564751344, 4411.360352748849, 4420.712653677533, 4457.465104187502, 4466.0844526871915, 4220.831166753326, 4237.724547904377, 4241.130568233505, 4302.548232435581, 4335.306350983859, 4304.203722311382, 4305.182015417061, 4382.715123516961, 4390.912181756347, 4391.802368893375, 4686.742229177394, 4718.339432479455, 4724.220503616899, 4732.574068333832, 4785.186518291899, 4915.0661374339115, 5057.2161314995865, 5059.797608095671, 5061.139606266944, 5122.257272695439, 4912.263160525949, 4948.579370753454, 4963.702177869303, 4988.950110498885, 5017.347744793154, 4629.86110416688, 4633.235516139866, 4634.281686338657, 4636.4899861015265, 4681.67228294023, 5062.316587260672, 5062.772175252123, 5062.797488100435, 5068.214426763858, 5127.102757017507, 4801.591864691541, 4850.320955066293, 4913.680610760289, 4941.184704523714, 4970.925436118461, 5047.722375269322, 5052.595792336604, 5056.494350564914, 5060.443351231362, 5108.0, 4977.726225057584, 4986.501349865057, 5011.974940125276, 5033.0688822567945, 5046.823361182341, 4765.642576806753, 4767.404074490689, 4817.9036419271415, 4853.39332583427, 4975.004999000214, 4158.043649960526, 4198.3702444633545, 4198.769067701244, 4232.386303985905, 4248.171606536695, 3655.6161603031833, 3659.853605855736, 3663.7984910829628, 3698.870539531157, 3703.685186759156, 4266.722663026893, 4322.589354011364, 4328.0, 4339.652827773771, 4364.279893817485, 5001.874953126201, 5041.546260836542, 5046.39443266803, 5070.6957582545165, 5118.232265160255, 4353.782310884443, 4362.192994296065, 4374.562543745664, 4379.430674012422, 4426.424564806554, 4396.274614688605, 4554.476235232924, 4556.0, 4556.134334476439, 4586.724796512153, 4651.534846515321, 4702.365180700698, 4730.432348118248, 4755.334253204485, 4783.354247176726, 5042.84871453857, 5057.468965758542, 5059.19052951526, 5067.5185857343495, 5117.513836185556, 4725.527447255247, 4736.928946065881, 4746.92879606813, 4748.0978614063215, 4807.206810876166, 4814.325994360723, 4829.323894654822, 4842.4673285937815, 4859.246816743411, 4885.511448855086, 4921.50784921505, 4931.926021109614, 4939.60483161339, 4940.036692844861, 4999.425066117297, 4817.9518204817505, 4826.879328016687, 4834.178189707688, 4852.611791056636, 4890.877728056827, 4734.053189362073, 4778.737169455713, 4839.95160048395, 4848.151573474557, 4874.463808980939, 4839.491853355487, 4850.05423942342, 4862.586680132228, 4879.048585525788, 4896.804127834846, 4793.5685788279225, 4914.311996320589, 4945.86285255983, 4955.331030310862, 5019.247112933089, 4718.315844202502, 4726.905461890812, 4775.570198682135, 4790.9281360780315, 4804.2073057946445], "value": 4597.335225841967, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.9163129714891, 547.7863633183061, 551.8868631930454, 567.9006173919565, 569.8119620525227, 26958.86520567397, 37620.24759504812, 38869.41695874564, 38873.61126388739, 42158.0, 39320.80339598305, 39726.64373700209, 39793.20413591734, 40013.19973600526, 40105.39841902374, 7638.083429988409, 7784.727534536292, 7788.649510772028, 7789.571573563452, 7792.883106753403, 7649.847003059936, 7732.381409487228, 7767.728129515468, 7772.06735191775, 7774.689012439496, 7784.494007889469, 7805.648745806452, 7833.490823096509, 7835.373170146375, 7837.804054898645, 7720.1121870985, 7727.227277272284, 7736.226377362275, 7744.0319960005, 7760.30157285847, 7655.693772249103, 7714.61426928657, 7728.0, 7738.458307918448, 7738.53568785869, 37131.443028354595, 37427.438588420926, 37427.812860935795, 37472.063198420256, 37489.25021499555, 2922.1379692990618, 2937.8429968981254, 3030.1364111228413, 3181.427343078245, 3190.888318908827, 26899.32751681204, 27369.589456158174, 27389.0, 27783.722162778315, 28055.859720701468, 3313.287643156709, 3329.4839299908554, 3350.229447227127, 3386.86452541898, 3422.9144271393166, 239533.0, 240228.0, 240253.0, 241153.0, 241594.0, 30642.387152257277, 48374.0, 48691.269630954856, 48779.0, 48817.0, 31222.375552488822, 32292.838535807172, 32337.191570210933, 32338.35323293521, 32350.514742278883, 12267.57063502773, 12476.563320283927, 12485.93757031209, 12488.0, 12497.375131243401, 9378.90621093794, 9462.195713364441, 9475.28935329853, 9477.052294770469, 9481.715548533555, 7279.6360181990685, 7479.065116860393, 7516.812079698051, 7526.698932042657, 7536.171021187774, 2885.4084912592866, 2901.2601786544296, 2942.941141177207, 2961.4965455872552, 2985.328301132228, 827.6383459170139, 852.2074470742269, 877.8244351129799, 912.3431129586687, 969.5200875566499, 26415.33961650974, 26940.865295673397, 27258.31854203621, 27373.0, 27579.03473378462, 761.885717142422, 924.4453328003144, 947.1475671895212, 958.6884262614678, 986.3933680786265, 13262.933685331705, 14345.426182952773, 14432.350544225535, 14462.566123016326, 14491.492797752027, 378015.1099244486, 380849.0, 381000.0, 381096.0, 382677.0, 47126.76436617795, 47359.28961065587, 47578.76210618925, 47652.761736191096, 47660.76169619129, 1056.6565866093551, 1077.8383242513685, 1084.0243780597368, 1143.3997151495364, 1189.637160665988, 26655.866720666272, 28077.0, 29481.0, 30624.693753062184, 30676.84661576678, 44085.77957110194, 44619.330710038725, 44648.33027504525, 44769.552304476536, 44793.552064478936, 334470.0, 336268.0, 336507.0, 336793.0, 338400.0, 24368.51262974766, 24459.87770061138, 24881.253562393158, 25038.37404064913, 25110.37224069413, 39844.0, 39905.401418979316, 40805.79597101996, 41140.382894256014, 41244.38133427941, 33554.83222583871, 34110.829445852614, 34613.480797787546, 34623.82688086543, 35122.64877351194, 33644.327113457104, 34451.4832277511, 34600.82699586486, 34619.48070778991, 34768.437050071865, 33400.83299583486, 33415.83292083524, 33580.0, 33985.66014339924, 34315.14212144716, 29322.56016159802, 31154.22114447157, 31193.53209701811, 31329.373412531168, 31908.521372178973, 24555.63166552539, 24913.50172996566, 24975.000999960524, 25171.496570068863, 25197.622035669112], "value": 15917.949613649316, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.81251405469953, 356.1985532551757, 357.3728107171914, 367.2984599415116, 385.25260993672276, 12292.508299668014, 13113.868861311385, 15538.456154034611, 16225.51323460298, 16548.0, 15877.603059923507, 16745.581360465996, 16753.413630522933, 16937.491875243733, 17090.401835935743, 4674.509176536466, 4822.156122678535, 4920.409550853894, 5163.870903227412, 5167.767450464719, 4968.900621987558, 5106.085218043234, 5109.054824857395, 5112.0287145442435, 5121.180611102224, 4878.829240976566, 5066.138756411419, 5074.822381216658, 5076.6700164489375, 5077.0, 4785.832495862645, 5039.84880453587, 5049.545540901318, 5049.697018178903, 5049.823256186016, 4357.891052723676, 4545.772711364419, 4546.045330480603, 4546.772661366918, 4554.590086892195, 19933.601327973505, 20015.0, 20107.597848043104, 20144.294949676692, 20167.991600420068, 1764.1884733022825, 1905.3902751119647, 1920.4718702356963, 1942.4561122885473, 2426.0780903256828, 7515.962420187919, 13271.469141234338, 13324.400401981935, 13582.864171358258, 13624.0, 1667.7998640163137, 1681.2770508681263, 1706.9231884565224, 1707.9743803842953, 1747.4058820001133, 65243.3475665242, 65786.3421365785, 66243.33756662419, 66298.0, 67051.0, 9245.768855778659, 9280.118388753057, 9549.952250238843, 9682.854757178648, 9693.0, 13246.139000964906, 13256.138351007154, 13279.074534192488, 13279.277748061624, 13286.402111904987, 6586.80239592813, 6857.182846545669, 6982.067531636725, 6996.160460744743, 7034.6834392452465, 6390.392912673288, 6393.200849893763, 6394.776182833579, 6525.543211975211, 6562.606243625398, 5895.41045895407, 5935.614185077956, 5954.970225148933, 6024.7106099682715, 6043.425874541911, 1705.5821323775506, 1714.297138173343, 1723.2073246306588, 1737.5916659584987, 1799.6490684316432, 751.9699212031458, 838.6100463284602, 909.8999110097884, 913.5474595393356, 939.3283802081545, 15644.0, 15729.752966698927, 15843.524694259191, 16702.4154154604, 17706.734398984026, 819.2381085590458, 857.935654825878, 858.0689951402674, 867.4058270085012, 882.1178821178821, 9441.0, 10129.139023182965, 10151.289409741396, 10168.135708464715, 10319.329243599143, 382606.0, 383118.0, 387957.0, 392299.0, 395838.0, 80173.59913200514, 83062.0, 84043.0, 84362.5781871099, 84893.0, 894.0344428017595, 895.8477058900003, 943.6508491857919, 944.2493217891792, 951.2295041016798, 15358.394186122208, 15373.154476503452, 16092.919535402249, 16419.67160656804, 16445.835541644432, 24936.0, 29071.418571628026, 29798.702012979593, 34715.30569388648, 36541.0, 48050.519494804605, 49324.0, 49809.50190498048, 50071.49928500814, 50507.24239136343, 6563.212414510289, 7008.159020917523, 7160.462965277521, 7326.4138868889295, 7425.628718564159, 10065.477083020884, 11139.610113645984, 11682.94158529202, 12163.635090947286, 12276.508939642672, 9689.951550242204, 9859.309848310837, 10414.271001030158, 10670.413127278074, 10993.856198041305, 10168.33905796121, 10380.221483388625, 10492.580296788348, 10627.734306642087, 10887.020168184901, 10298.639547616098, 10301.639442619473, 10344.534495947852, 10658.253922225369, 11098.167637427387, 7015.894761578683, 7105.360517553445, 7116.857662846611, 7207.891881621885, 7222.09723784527, 8792.0, 10504.10715089226, 10549.736256593647, 10552.155827533625, 10901.310296903992], "value": 8096.268936518992, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1229.9139060265784, 1309.135970259629, 1356.9864301356986, 1375.6560859785054, 1660.8837381383294, 6471.158749362582, 7025.894611580824, 7235.348818606331, 7533.811654708635, 7536.397088232942, 7589.241075892408, 7655.655495502702, 7662.233776622335, 7665.770026899188, 7668.348190403808, 2076.5743022680354, 2084.551821358408, 2096.842736794739, 2102.3797979596056, 2109.261758384561, 1988.5128143604836, 2033.9593208135827, 2040.3776848061336, 2060.701198326249, 2076.9376918692387, 2072.761632412269, 2088.321295578943, 2090.5400811821373, 2095.067694875781, 2097.4441772930186, 2020.0202901592716, 2026.4629873083645, 2032.8475364347732, 2038.0930485933766, 2040.9183632654676, 1967.5868067705799, 2004.5790384019374, 2005.9398218053482, 2012.4465771912694, 2022.1506967073865, 7450.701971921117, 7500.399968002546, 7582.772516824504, 7590.658420371096, 7603.0, 4212.241796476633, 4374.934375984363, 4376.5623437656295, 4433.246348120827, 4434.711743736679, 2619.7773189278932, 2713.9592906106423, 2743.890244390222, 2765.363966287745, 2767.045369347592, 807.6648191000728, 818.6152508321079, 822.0998007182126, 822.9588520574007, 849.7110982265997, 9669.468179250138, 9746.26902982272, 9781.0, 9803.362781419184, 9804.754881127958, 3554.0581745837376, 3589.5333606631493, 3716.7398282119993, 3806.847726090981, 3835.846566137379, 7749.4575379724, 7759.68961241544, 7761.301482866569, 7761.883571746428, 7773.261540153676, 4103.5691252418665, 4108.157827645326, 4108.979455102765, 4110.445089912883, 4111.177764447063, 3444.5522082129664, 3570.6072332043454, 3783.243351329745, 3793.886183414502, 3834.9616503834604, 3145.150809281481, 3186.267158553546, 3282.3107147498813, 3304.289577740797, 3306.272620023591, 933.2254228989922, 941.110650435332, 941.9105185007413, 943.2785167070125, 948.3835506920419, 773.4122067228834, 784.1491981200461, 787.1577412169039, 797.1589972578869, 804.8631732605471, 4661.440627124767, 4829.372181616367, 4844.491328410537, 4858.198397264482, 5009.0983622948215, 836.9832603347899, 845.691322667222, 846.6147902704378, 849.5497386385226, 859.2266959736287, 3311.718503927145, 3352.6479719629087, 3370.8483118259737, 3417.6411476795074, 3475.808830514346, 8682.262007729414, 9180.357374983687, 9180.403273787182, 9186.86219706705, 9190.035046320174, 8986.236169925498, 9130.0, 9223.308251881135, 9253.352265341497, 9300.581473833694, 6797.218319893275, 6917.239103698589, 6923.446124310043, 6928.792136235921, 6930.514863959575, 4810.783514741915, 4833.468318484894, 4913.6069114471475, 4939.308496810521, 4981.128302547112, 7817.218278172138, 8193.877091843508, 8201.466904651179, 8264.586770661323, 8298.626561804613, 8368.24685778283, 8369.121242269473, 8374.748757537283, 8384.958075209584, 8667.17661822126, 5886.852828679317, 6469.4824414045825, 6613.404793568602, 6618.0, 6618.1065556151225, 6634.767783127568, 6834.555753875982, 7075.71697132109, 7135.286471352823, 7278.053852999288, 6223.159873417031, 6322.810315690536, 6630.3038180992235, 6658.300878407697, 6764.695588698619, 6575.638339891352, 6606.372394622503, 6616.0, 6632.436242919406, 6650.800475985729, 5927.436893495111, 6007.068904319663, 6009.128676341818, 6011.338752737282, 6027.246594175728, 4289.7640629765665, 4346.934795978, 4373.2128216921255, 4406.845760398371, 4456.665750068693, 4355.368471571541, 4374.606285434326, 4454.376387305844, 4467.553244675506, 4516.728996260234], "value": 3856.906999472037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.74888223921835, 286.55869960261197, 290.76302813207235, 293.6608217508778, 299.19068918575255, 4874.415070191578, 4894.510548945103, 4899.510048995103, 4908.312836202935, 4916.459189489154, 4772.8090876364995, 4775.976120119394, 4798.856034318976, 4863.392075990501, 4877.3903262092235, 3527.259275552131, 3619.3123306571665, 3639.126609613687, 3692.686121679647, 3765.5293088363956, 3750.737448378601, 3774.9622503774885, 3776.5090538229992, 3784.7161462890253, 3816.7709937403706, 3737.084414318496, 3745.7003439724895, 3748.0697440818, 3773.8301776420126, 3788.5074940257864, 3570.410882204433, 3597.892063238107, 3692.332269965617, 3723.8510459581585, 3733.3653278942643, 3270.8201048942296, 3271.362084393544, 3279.475283954556, 3281.606207255121, 3285.769996100274, 4686.53134686532, 4687.7108795081285, 4689.671722979393, 4691.0, 4722.433308003027, 4179.185058913513, 4265.317549192115, 4274.636655884254, 4302.569743025703, 4316.611504964569, 4960.950390496085, 4963.106640804654, 4969.055879382906, 4977.527134922177, 5006.148954677714, 3629.8366573504254, 3630.8547658093644, 3635.8182090895616, 3649.197176621139, 3651.269746050774, 5003.574696150831, 5261.3686357637325, 5280.471952804689, 5305.726625609865, 5316.867078323035, 3533.982330088333, 3534.896736441813, 3539.3275277697153, 3552.5914519830035, 3566.928661426809, 3577.2130131371055, 3577.4276115821344, 3583.802890841029, 3604.3151801157696, 3606.2967721294094, 4156.709030367845, 4158.521769996429, 4159.209750147463, 4160.251154792167, 4161.188568229227, 4845.224764037807, 5014.623903207274, 5048.671836330626, 5081.780372710597, 5101.540861322499, 1292.9979266068683, 1299.493197652916, 1303.9503199924152, 1304.6738315421144, 1307.1372893889986, 795.4431897671653, 829.5354601423222, 833.3125171733344, 843.304273973974, 849.8017794909149, 4268.423762792046, 4391.253486907233, 4434.889127771831, 4511.4886513017855, 4515.841945531956, 5185.948140518622, 5197.7141257231215, 5208.322918020633, 5241.9213711794355, 5253.89668169681, 4485.977570112129, 4490.865274041784, 4508.301213311942, 4516.728996260234, 4548.658850586219, 2614.9215523534326, 2727.990643461932, 2729.549624312006, 2756.9035083771973, 2757.131503576367, 4875.902481950341, 4883.780229889663, 4911.263310503453, 4912.631552633496, 4927.852164435073, 5114.667546609458, 5353.197020446964, 5356.223347614574, 5362.490563396471, 5405.324334458192, 4844.709317440965, 4850.9085455772165, 4853.611711063107, 4902.583280421204, 4936.185529387611, 5179.1195496764885, 5181.3005244291535, 5188.844334669966, 5199.220116982483, 5292.655977361459, 4941.456439791692, 5084.923726144037, 5161.587073034223, 5164.302819119371, 5177.870553236199, 4866.1046677227, 4889.755512224303, 4890.657653964331, 4902.656814023127, 4932.728699921395, 3705.314516814398, 3709.5919448860063, 3717.1450566369344, 3739.2521495701512, 3760.962390376171, 4917.606591472602, 5184.911168654625, 5187.559057480156, 5198.8960220796125, 5200.2199670049795, 4978.800847966186, 4986.32684587576, 4993.975030124826, 4998.725070121178, 5026.246063090565, 4995.350604421402, 4995.400551933792, 4999.300097986212, 5087.491250874883, 5093.2105523643895, 4689.929651055305, 4938.629602779734, 4946.901061978669, 4979.526944940225, 4986.775595098156, 4851.2723091535145, 4974.477679843564, 5084.872878178076, 5095.363079615048, 5120.641555091108, 4831.236598641541, 4948.455669876239, 4977.208205046108, 4982.533645845329, 4990.707991127555], "value": 3784.5537812416655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.802303262956, 617.9969100154499, 637.1875858280695, 695.4957655699617, 706.554870431628, 13117.934410327947, 13795.034347595672, 13800.930995345021, 13807.102538335013, 13819.0, 13128.474861005572, 13139.474421023147, 13147.145435546683, 13161.868381316208, 13166.144200626977, 613.175279249411, 631.0691729698681, 737.6164394514876, 748.8839229919371, 764.9847003059936, 765.4871236271683, 767.4052609227865, 768.174212721324, 768.5734417398342, 768.6348984232501, 811.9472234304751, 812.1229072601576, 813.8453693798189, 814.42989907065, 815.1278132398336, 635.3075148088583, 657.8486948001986, 658.8748137853793, 662.3906006474056, 810.8621534339177, 489.3955964383983, 570.7431655754926, 583.8306891001605, 585.9384764599741, 590.9290885093774, 12400.627981160489, 12424.627261182179, 12439.129260951737, 12448.439820208112, 12449.626511204679, 11753.88246117545, 12034.157608967376, 12163.817542736866, 12489.875101248963, 12638.004935705903, 10362.430066346347, 10471.062988193466, 10541.894581054168, 10567.68296951085, 10657.680269591925, 3789.4315852622053, 3804.3912973924316, 3810.923781524382, 3815.2178803345246, 3877.6316249956208, 60060.39939600635, 60597.0, 61590.69204653948, 62109.689451552455, 63211.051834222526, 9059.728208153765, 9071.546422678839, 9293.070692930789, 9305.022972587916, 9389.0, 18514.351997680016, 18553.35063272779, 18602.162902669414, 18641.53396165107, 18661.81338186628, 6493.935060649427, 6520.967395163088, 6521.739130434729, 6552.213734351813, 6555.475561955032, 3402.625711171769, 3590.2281009583066, 3648.1791596891017, 3661.56061272649, 3670.302642497917, 2726.700062993069, 2780.165950214968, 2806.9017584384446, 2812.73279038491, 2814.3808362160294, 481.3670023918536, 491.77132633325675, 497.6392115716077, 502.7988804478238, 504.09011733820074, 446.67283453209143, 500.279597379772, 539.3339226055818, 543.2665901033573, 546.8468828727963, 6821.1814582250445, 7135.215126336099, 7436.776896693108, 7479.887801682979, 7640.885386719204, 454.7521600727611, 503.6147347279334, 525.1571228178794, 533.5704757670113, 565.0761005755619, 3375.8818441354433, 3459.3600183965546, 3584.8386822593047, 3666.3400587893902, 3855.575886652466, 94207.52896235474, 95148.52425737827, 95892.0, 98220.50889745649, 102860.48569757103, 63907.680461597396, 64708.35291647117, 88261.0, 90171.0, 91241.0, 59028.40971590315, 64954.35045649578, 69124.65437672779, 70169.29830701627, 70405.64797175981, 8156.714514991947, 8507.95746021266, 8544.786380340542, 8754.952910021377, 8764.956175219084, 36262.0, 37258.0, 37773.24453510969, 38279.42580861345, 42345.0, 37534.43698344582, 38538.0, 45793.54206457893, 59165.704171478865, 59990.10014849693, 10676.83984740245, 11170.218084733991, 11295.039921606756, 11328.0, 11554.653360399201, 12512.186707863959, 12628.621141365773, 12812.55156069533, 13448.462061517821, 13689.452421903012, 10907.454627268446, 11098.944505277423, 11388.829167562659, 11480.253783504046, 11688.649340519798, 11511.251768635011, 12248.448819803309, 12250.448729807002, 12526.185797923106, 12791.936040319739, 11091.5563377464, 11561.190716649753, 11581.942090289831, 11600.213341840517, 11950.282983021047, 8735.825283494421, 8898.777530561787, 9159.908400916172, 9908.166989107038, 10003.599856005969, 9396.76508087276, 10012.64955726546, 10136.847947280945, 10140.797184056426, 10152.39085654863], "value": 6276.119846472805, "unit": "score"}], "name": "dromaeo_css", "value": 6153.354840532067, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 116.0, 115.0, 115.0, 114.0, 114.0, 114.0, 116.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 132.0, 129.0, 187.0, 126.0, 128.0, 127.0, 134.0, 179.0, 127.0], "value": 142.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 160.0, 160.0, 160.0, 162.0, 161.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 110.0, 76.0, 76.0, 76.0, 75.0, 99.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 82.0, 120.0, 83.0, 83.0, 84.0, 109.0, 83.0, 83.0, 118.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 65.0, 64.0, 65.0, 63.0, 64.0, 66.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 68.0, 65.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 93.0, 87.0, 94.0, 84.0, 84.0, 99.0, 84.0, 84.0, 92.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 141.0, 149.0, 139.0, 150.0, 141.0, 141.0, 140.0, 174.0, 143.0], "value": 146.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 190.0, 177.0, 183.0, 180.0, 181.0, 177.0, 176.0, 177.0, 178.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 72.0, 74.0, 75.0, 73.0, 70.0, 70.0, 79.0], "value": 72.4, "unit": "score"}], "name": "kraken", "value": 1569.4, "alertThreshold": 2.0}]} 09:05:38 INFO - Return code: 0 09:05:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:38 INFO - # TBPL SUCCESS # 09:05:38 INFO - Running post-action listener: _resource_record_post_action 09:05:38 INFO - [mozharness: 2016-10-04 16:05:38.252246Z] Finished run-tests step (success) 09:05:38 INFO - Running post-run listener: _resource_record_post_run 09:05:38 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 421888; Write bytes: 392351744; Read time: 24; Write time: 208112 09:05:38 INFO - TinderboxPrint: CPU usage
13.0% 09:05:38 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 24 09:05:38 INFO - TinderboxPrint: I/O write bytes / time
392,351,744 / 208,112 09:05:38 INFO - TinderboxPrint: CPU idle
8,347.9 (87.0%) 09:05:38 INFO - TinderboxPrint: CPU user
1,202.5 (12.5%) 09:05:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99954688; Read time: 0; Write time: 51272 09:05:38 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 417792; Write bytes: 292397056; Read time: 16; Write time: 156840 09:05:38 INFO - Running post-run listener: _upload_blobber_files 09:05:38 INFO - Blob upload gear active. 09:05:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:05:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:40 INFO - (blobuploader) - INFO - Done attempting. 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:40 INFO - (blobuploader) - INFO - Done attempting. 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:44 INFO - (blobuploader) - INFO - Done attempting. 09:05:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:44 INFO - Return code: 0 09:05:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d702d0ab24d91f050eefbc05527bb5793957473a8d73321669c31f4f3dcd67086955f47150118d4c8294bec4a4273b74f50e5c7e50ef4e06e5bdf29e5ea4d044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d27952e4e3b71c9453a5406f3bcf2eb9b0d7ee7b09b05427b0d7c189ce9817cce5900520907afc301ef571a56541f14a9547d0071f6b2e4f177939a5780bf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52f7b6f97c012e62ff386ffc7729bc859240c7805d7dfa3216178f1975f454181dff85e8b587d5c75789d5b6b8da5ad469dc9e00bf51a037b536759fab000a2e"} 09:05:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:44 INFO - Contents: 09:05:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d702d0ab24d91f050eefbc05527bb5793957473a8d73321669c31f4f3dcd67086955f47150118d4c8294bec4a4273b74f50e5c7e50ef4e06e5bdf29e5ea4d044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d27952e4e3b71c9453a5406f3bcf2eb9b0d7ee7b09b05427b0d7c189ce9817cce5900520907afc301ef571a56541f14a9547d0071f6b2e4f177939a5780bf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52f7b6f97c012e62ff386ffc7729bc859240c7805d7dfa3216178f1975f454181dff85e8b587d5c75789d5b6b8da5ad469dc9e00bf51a037b536759fab000a2e"} 09:05:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:44 INFO - Copying logs to upload dir... 09:05:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.360719 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 09:05:44.465231) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:05:44.469192) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 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/d702d0ab24d91f050eefbc05527bb5793957473a8d73321669c31f4f3dcd67086955f47150118d4c8294bec4a4273b74f50e5c7e50ef4e06e5bdf29e5ea4d044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d27952e4e3b71c9453a5406f3bcf2eb9b0d7ee7b09b05427b0d7c189ce9817cce5900520907afc301ef571a56541f14a9547d0071f6b2e4f177939a5780bf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52f7b6f97c012e62ff386ffc7729bc859240c7805d7dfa3216178f1975f454181dff85e8b587d5c75789d5b6b8da5ad469dc9e00bf51a037b536759fab000a2e"} build_url:https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/OTW_ziIARcyleci_CbZhDQ/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/d702d0ab24d91f050eefbc05527bb5793957473a8d73321669c31f4f3dcd67086955f47150118d4c8294bec4a4273b74f50e5c7e50ef4e06e5bdf29e5ea4d044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8d27952e4e3b71c9453a5406f3bcf2eb9b0d7ee7b09b05427b0d7c189ce9817cce5900520907afc301ef571a56541f14a9547d0071f6b2e4f177939a5780bf24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/52f7b6f97c012e62ff386ffc7729bc859240c7805d7dfa3216178f1975f454181dff85e8b587d5c75789d5b6b8da5ad469dc9e00bf51a037b536759fab000a2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 09:05:44.500053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:05:44.500725) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1475593231.440761-399259703 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 09:05:44.583096) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:05:44.583918) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 09:05:44.584619) ========= ========= Total master_lag: 0.18 =========