builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1477888844.49 results: success (0) buildid: 20161030200921 builduid: a7ca0795f8884e61985c676e903a2efc revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.493427) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.493892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.494203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.509081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.509407) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 21:40:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-10-30 21:40:44 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120446 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.650649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.650966) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017946 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.700155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:44.700598) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e017b947cea08b7bdd21007e95bd13e14ad59103 --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 e017b947cea08b7bdd21007e95bd13e14ad59103 --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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 21:40:44,958 truncating revision to first 12 chars 2016-10-30 21:40:44,958 Setting DEBUG logging. 2016-10-30 21:40:44,958 attempt 1/10 2016-10-30 21:40:44,958 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e017b947cea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 21:40:45,370 unpacking tar archive at: fx-team-e017b947cea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.744800 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:45.455842) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:45.456165) ========= script_repo_revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:45.456599) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:45.456903) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 21:40:45.467788) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-30 21:40:45.468113) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:40:45 INFO - MultiFileLogger online at 20161030 21:40:45 in /builds/slave/test 21:40:45 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 21:40:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:40:45 INFO - {'append_to_log': False, 21:40:45 INFO - 'base_work_dir': '/builds/slave/test', 21:40:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:40:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:40:45 INFO - 'branch': 'Fx-Team-Non-PGO', 21:40:45 INFO - 'buildbot_json_path': 'buildprops.json', 21:40:45 INFO - 'config_files': ('talos/linux_config.py',), 21:40:45 INFO - 'default_actions': ('clobber', 21:40:45 INFO - 'read-buildbot-config', 21:40:45 INFO - 'download-and-extract', 21:40:45 INFO - 'populate-webroot', 21:40:45 INFO - 'create-virtualenv', 21:40:45 INFO - 'install', 21:40:45 INFO - 'run-tests'), 21:40:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:40:45 INFO - 'download_minidump_stackwalk': True, 21:40:45 INFO - 'download_symbols': 'ondemand', 21:40:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:40:45 INFO - 'tooltool.py': '/tools/tooltool.py', 21:40:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:40:45 INFO - '/tools/misc-python/virtualenv.py')}, 21:40:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:40:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:40:45 INFO - 'installer_path': 'installer.exe', 21:40:45 INFO - 'log_level': 'info', 21:40:45 INFO - 'log_name': 'talos', 21:40:45 INFO - 'log_to_console': True, 21:40:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:40:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:40:45 INFO - 'opt_config_files': (), 21:40:45 INFO - 'pip_index': False, 21:40:45 INFO - 'sps_profile': False, 21:40:45 INFO - 'sps_profile_interval': 0, 21:40:45 INFO - 'suite': 'dromaeojs', 21:40:45 INFO - 'system_bits': '32', 21:40:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:40:45 INFO - 'title': 'talos-linux64-ix-061', 21:40:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:40:45 INFO - 'use_talos_json': True, 21:40:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:40:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:40:45 INFO - 'work_dir': 'build'} 21:40:45 INFO - [mozharness: 2016-10-31 04:40:45.826262Z] Running clobber step. 21:40:45 INFO - Running pre-action listener: _resource_record_pre_action 21:40:45 INFO - Running main action method: clobber 21:40:45 INFO - rmtree: /builds/slave/test/build 21:40:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:40:46 INFO - Running post-action listener: _resource_record_post_action 21:40:46 INFO - [mozharness: 2016-10-31 04:40:46.287368Z] Finished clobber step (success) 21:40:46 INFO - [mozharness: 2016-10-31 04:40:46.287470Z] Running read-buildbot-config step. 21:40:46 INFO - Running pre-action listener: _resource_record_pre_action 21:40:46 INFO - Running main action method: read_buildbot_config 21:40:46 INFO - Using buildbot properties: 21:40:46 INFO - { 21:40:46 INFO - "project": "", 21:40:46 INFO - "product": "firefox", 21:40:46 INFO - "script_repo_revision": "production", 21:40:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:40:46 INFO - "repository": "", 21:40:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:40:46 INFO - "buildid": "20161030200921", 21:40:46 INFO - "pgo_build": "False", 21:40:46 INFO - "basedir": "/builds/slave/test", 21:40:46 INFO - "buildnumber": 3404, 21:40:46 INFO - "slavename": "talos-linux64-ix-061", 21:40:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:40:46 INFO - "platform": "ubuntu64_hw", 21:40:46 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:40:46 INFO - "branch": "fx-team", 21:40:46 INFO - "repo_path": "integration/fx-team", 21:40:46 INFO - "revision": "e017b947cea08b7bdd21007e95bd13e14ad59103", 21:40:46 INFO - "stage_platform": "linux64", 21:40:46 INFO - "builduid": "a7ca0795f8884e61985c676e903a2efc", 21:40:46 INFO - "slavebuilddir": "test" 21:40:46 INFO - } 21:40:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:40:46 INFO - Running post-action listener: _resource_record_post_action 21:40:46 INFO - [mozharness: 2016-10-31 04:40:46.289902Z] Finished read-buildbot-config step (success) 21:40:46 INFO - [mozharness: 2016-10-31 04:40:46.289991Z] Running download-and-extract step. 21:40:46 INFO - Running pre-action listener: _resource_record_pre_action 21:40:46 INFO - Running main action method: download_and_extract 21:40:46 INFO - mkdir: /builds/slave/test/build/tests 21:40:46 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')]} 21:40:46 INFO - trying https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:40:46 INFO - Downloading https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/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 21:40:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/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 21:40:46 INFO - Downloaded 1361 bytes. 21:40:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:40:46 INFO - Using the following test package requirements: 21:40:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:40:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:40:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:40:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'jsshell-linux-x86_64.zip'], 21:40:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:40:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:40:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:40:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:40:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:40:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:40:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:40:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:40:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:40:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:40:46 INFO - Fetch https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:40:47 INFO - Http code: 200 21:40:47 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 21:40:47 INFO - x-amz-cf-id: -B109qtc4qWx_TUCUCG25HQmyLEKzUQgX-7mxZ3rghTFWTfdVIMLoQ== 21:40:47 INFO - x-amz-version-id: Nxuypwo3ZbssSeDYVLrSTbuyfqbNHeU4 21:40:48 INFO - Expected file size: 20439821 21:40:48 INFO - Obtained file size: 20439821 21:40:52 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 21:40:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:40:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:40:52 INFO - Fetch https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:40:52 INFO - Http code: 200 21:40:52 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 21:40:52 INFO - x-amz-cf-id: E60lLJ3xfixHQPRWlE2RIbxkof_v6muwM5hfbSKlSgxNSMXn7IdOWQ== 21:40:52 INFO - x-amz-version-id: Nxuypwo3ZbssSeDYVLrSTbuyfqbNHeU4 21:40:53 INFO - Expected file size: 20439821 21:40:53 INFO - Obtained file size: 20439821 21:40:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:40:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:40:57 INFO - Fetch https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:40:58 INFO - Http code: 200 21:40:58 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 21:40:58 INFO - x-amz-cf-id: iS-UPP_T4-MxDs-46Cmo1BEqg7SfTcoa242slyk1XWGy1UN3CQ9p5Q== 21:40:58 INFO - x-amz-version-id: 7X9Q2fqyGJ8QDpWCA_A.MrdJiOI9MRaT 21:40:59 INFO - Expected file size: 14409038 21:40:59 INFO - Obtained file size: 14409038 21:40:59 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')]} 21:40:59 INFO - trying https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:40:59 INFO - Downloading https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/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 21:40:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/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 21:41:01 INFO - Downloaded 55808752 bytes. 21:41:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:41:01 INFO - mkdir: /builds/slave/test/properties 21:41:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:41:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:41:01 INFO - Contents: 21:41:01 INFO - build_url:https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:41:02 INFO - Running post-action listener: _resource_record_post_action 21:41:02 INFO - Running post-action listener: set_extra_try_arguments 21:41:02 INFO - [mozharness: 2016-10-31 04:41:02.226991Z] Finished download-and-extract step (success) 21:41:02 INFO - [mozharness: 2016-10-31 04:41:02.227219Z] Running populate-webroot step. 21:41:02 INFO - Running pre-action listener: _resource_record_pre_action 21:41:02 INFO - Running main action method: populate_webroot 21:41:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:41:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:41:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:41:02 INFO - '--tppagecycles', 21:41:02 INFO - '7'], 21:41:02 INFO - 'tests': ['tsvgm']}}, 21:41:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:41:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:41:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:41:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:41:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:41:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['damp', 'tps']}, 21:41:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'tests': ['damp', 'tps']}, 21:41:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['dromaeo_dom']}, 21:41:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:41:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['basic_compositor_video']}, 21:41:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:41:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'other-e10s': {'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['a11yr', 21:41:02 INFO - 'ts_paint', 21:41:02 INFO - 'tpaint', 21:41:02 INFO - 'sessionrestore', 21:41:02 INFO - 'sessionrestore_no_auto_restore', 21:41:02 INFO - 'tabpaint']}, 21:41:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['tsvgx', 21:41:02 INFO - 'tsvgr_opacity', 21:41:02 INFO - 'tart', 21:41:02 INFO - 'tscrollx', 21:41:02 INFO - 'cart']}, 21:41:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:41:02 INFO - 'tsvgr_opacity', 21:41:02 INFO - 'tart', 21:41:02 INFO - 'tscrollx', 21:41:02 INFO - 'cart']}, 21:41:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'talos_options': ['--disable-e10s'], 21:41:02 INFO - 'tests': ['tp5o']}, 21:41:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'tests': ['tp5o']}, 21:41:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'talos_options': ['--disable-e10s', 21:41:02 INFO - '--xperf_path', 21:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:02 INFO - 'tests': ['tp5n']}, 21:41:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:41:02 INFO - 'talos_options': ['--xperf_path', 21:41:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:41:02 INFO - 'tests': ['tp5n']}}, 21:41:02 INFO - 'talos.zip': {'path': '', 21:41:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:41:02 INFO - Running post-action listener: _resource_record_post_action 21:41:02 INFO - [mozharness: 2016-10-31 04:41:02.248031Z] Finished populate-webroot step (success) 21:41:02 INFO - [mozharness: 2016-10-31 04:41:02.248120Z] Running create-virtualenv step. 21:41:02 INFO - Running pre-action listener: _resource_record_pre_action 21:41:02 INFO - Running main action method: create_virtualenv 21:41:02 INFO - Creating virtualenv /builds/slave/test/build/venv 21:41:02 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 21:41:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:41:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:41:02 INFO - Using real prefix '/usr' 21:41:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:41:02 INFO - Installing distribute.............................................................................................................................................................................................done. 21:41:04 INFO - Installing pip.................done. 21:41:04 INFO - Return code: 0 21:41:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:41:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:41:05 INFO - Reading from file tmpfile_stdout 21:41:05 INFO - Output received: 21:41:05 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) 21:41:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:41:05 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')]} 21:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:05 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')]} 21:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:05 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:05 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 21:41:05 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 21:41:05 INFO - Using env: {'DISPLAY': ':0', 21:41:05 INFO - 'HOME': '/home/cltbld', 21:41:05 INFO - 'LANG': 'en_US.UTF-8', 21:41:05 INFO - 'LANGUAGE': 'en_US:en', 21:41:05 INFO - 'LOGNAME': 'cltbld', 21:41:05 INFO - 'MAIL': '/var/mail/cltbld', 21:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:05 INFO - 'MOZ_NO_REMOTE': '1', 21:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:05 INFO - 'NO_EM_RESTART': '1', 21:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:05 INFO - 'PWD': '/builds/slave/test', 21:41:05 INFO - 'SHELL': '/bin/bash', 21:41:05 INFO - 'SHLVL': '1', 21:41:05 INFO - 'TERM': 'linux', 21:41:05 INFO - 'TMOUT': '86400', 21:41:05 INFO - 'USER': 'cltbld', 21:41:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:05 INFO - '_': '/tools/buildbot/bin/python'} 21:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:05 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 21:41:05 INFO - Cleaning up... 21:41:05 INFO - Return code: 0 21:41:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:41:05 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')]} 21:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:05 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')]} 21:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:05 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:05 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 21:41:05 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 21:41:05 INFO - Using env: {'DISPLAY': ':0', 21:41:05 INFO - 'HOME': '/home/cltbld', 21:41:05 INFO - 'LANG': 'en_US.UTF-8', 21:41:05 INFO - 'LANGUAGE': 'en_US:en', 21:41:05 INFO - 'LOGNAME': 'cltbld', 21:41:05 INFO - 'MAIL': '/var/mail/cltbld', 21:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:05 INFO - 'MOZ_NO_REMOTE': '1', 21:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:05 INFO - 'NO_EM_RESTART': '1', 21:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:05 INFO - 'PWD': '/builds/slave/test', 21:41:05 INFO - 'SHELL': '/bin/bash', 21:41:05 INFO - 'SHLVL': '1', 21:41:05 INFO - 'TERM': 'linux', 21:41:05 INFO - 'TMOUT': '86400', 21:41:05 INFO - 'USER': 'cltbld', 21:41:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:05 INFO - '_': '/tools/buildbot/bin/python'} 21:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:05 INFO - Downloading/unpacking psutil>=3.1.1 21:41:05 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 21:41:05 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 21:41:05 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 21:41:05 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 21:41:05 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 21:41:05 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 21:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:07 INFO - Installing collected packages: psutil 21:41:07 INFO - Running setup.py install for psutil 21:41:07 INFO - building 'psutil._psutil_linux' extension 21:41:07 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 21:41:07 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 21:41:07 INFO - building 'psutil._psutil_posix' extension 21:41:07 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 21:41:07 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 21:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:41:07 INFO - Successfully installed psutil 21:41:07 INFO - Cleaning up... 21:41:08 INFO - Return code: 0 21:41:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:41:08 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')]} 21:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:08 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')]} 21:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:08 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:08 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 21:41:08 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 21:41:08 INFO - Using env: {'DISPLAY': ':0', 21:41:08 INFO - 'HOME': '/home/cltbld', 21:41:08 INFO - 'LANG': 'en_US.UTF-8', 21:41:08 INFO - 'LANGUAGE': 'en_US:en', 21:41:08 INFO - 'LOGNAME': 'cltbld', 21:41:08 INFO - 'MAIL': '/var/mail/cltbld', 21:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:08 INFO - 'MOZ_NO_REMOTE': '1', 21:41:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:08 INFO - 'NO_EM_RESTART': '1', 21:41:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:08 INFO - 'PWD': '/builds/slave/test', 21:41:08 INFO - 'SHELL': '/bin/bash', 21:41:08 INFO - 'SHLVL': '1', 21:41:08 INFO - 'TERM': 'linux', 21:41:08 INFO - 'TMOUT': '86400', 21:41:08 INFO - 'USER': 'cltbld', 21:41:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:08 INFO - '_': '/tools/buildbot/bin/python'} 21:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:08 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 21:41:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:41:10 INFO - Installing collected packages: mozsystemmonitor 21:41:10 INFO - Running setup.py install for mozsystemmonitor 21:41:10 INFO - Successfully installed mozsystemmonitor 21:41:10 INFO - Cleaning up... 21:41:10 INFO - Return code: 0 21:41:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:41:10 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')]} 21:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:10 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')]} 21:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:10 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:10 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 21:41:10 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 21:41:10 INFO - Using env: {'DISPLAY': ':0', 21:41:10 INFO - 'HOME': '/home/cltbld', 21:41:10 INFO - 'LANG': 'en_US.UTF-8', 21:41:10 INFO - 'LANGUAGE': 'en_US:en', 21:41:10 INFO - 'LOGNAME': 'cltbld', 21:41:10 INFO - 'MAIL': '/var/mail/cltbld', 21:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:10 INFO - 'MOZ_NO_REMOTE': '1', 21:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:10 INFO - 'NO_EM_RESTART': '1', 21:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:10 INFO - 'PWD': '/builds/slave/test', 21:41:10 INFO - 'SHELL': '/bin/bash', 21:41:10 INFO - 'SHLVL': '1', 21:41:10 INFO - 'TERM': 'linux', 21:41:10 INFO - 'TMOUT': '86400', 21:41:10 INFO - 'USER': 'cltbld', 21:41:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:10 INFO - '_': '/tools/buildbot/bin/python'} 21:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:10 INFO - Downloading/unpacking jsonschema==2.5.1 21:41:10 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 21:41:10 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 21:41:10 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 21:41:10 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 21:41:10 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 21:41:10 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 21:41:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:41:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:41:12 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 21:41:12 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 21:41:12 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 21:41:12 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 21:41:12 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 21:41:12 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 21:41:12 INFO - Downloading functools32-3.2.3-2.tar.gz 21:41:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:41:12 INFO - warning: no files found matching '*.txt' 21:41:12 INFO - no previously-included directories found matching 'build' 21:41:12 INFO - no previously-included directories found matching 'dist' 21:41:12 INFO - no previously-included directories found matching '.git*' 21:41:12 INFO - Installing collected packages: jsonschema, functools32 21:41:12 INFO - Running setup.py install for functools32 21:41:12 INFO - warning: no files found matching '*.txt' 21:41:12 INFO - no previously-included directories found matching 'build' 21:41:12 INFO - no previously-included directories found matching 'dist' 21:41:12 INFO - no previously-included directories found matching '.git*' 21:41:12 INFO - Successfully installed jsonschema functools32 21:41:12 INFO - Cleaning up... 21:41:13 INFO - Return code: 0 21:41:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:13 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:13 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 21:41:13 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 21:41:13 INFO - Using env: {'DISPLAY': ':0', 21:41:13 INFO - 'HOME': '/home/cltbld', 21:41:13 INFO - 'LANG': 'en_US.UTF-8', 21:41:13 INFO - 'LANGUAGE': 'en_US:en', 21:41:13 INFO - 'LOGNAME': 'cltbld', 21:41:13 INFO - 'MAIL': '/var/mail/cltbld', 21:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:13 INFO - 'MOZ_NO_REMOTE': '1', 21:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:13 INFO - 'NO_EM_RESTART': '1', 21:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:13 INFO - 'PWD': '/builds/slave/test', 21:41:13 INFO - 'SHELL': '/bin/bash', 21:41:13 INFO - 'SHLVL': '1', 21:41:13 INFO - 'TERM': 'linux', 21:41:13 INFO - 'TMOUT': '86400', 21:41:13 INFO - 'USER': 'cltbld', 21:41:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:13 INFO - '_': '/tools/buildbot/bin/python'} 21:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:41:13 INFO - Cleaning up... 21:41:13 INFO - Return code: 0 21:41:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:13 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:13 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 21:41:13 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 21:41:13 INFO - Using env: {'DISPLAY': ':0', 21:41:13 INFO - 'HOME': '/home/cltbld', 21:41:13 INFO - 'LANG': 'en_US.UTF-8', 21:41:13 INFO - 'LANGUAGE': 'en_US:en', 21:41:13 INFO - 'LOGNAME': 'cltbld', 21:41:13 INFO - 'MAIL': '/var/mail/cltbld', 21:41:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:13 INFO - 'MOZ_NO_REMOTE': '1', 21:41:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:13 INFO - 'NO_EM_RESTART': '1', 21:41:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:13 INFO - 'PWD': '/builds/slave/test', 21:41:13 INFO - 'SHELL': '/bin/bash', 21:41:13 INFO - 'SHLVL': '1', 21:41:13 INFO - 'TERM': 'linux', 21:41:13 INFO - 'TMOUT': '86400', 21:41:13 INFO - 'USER': 'cltbld', 21:41:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:13 INFO - '_': '/tools/buildbot/bin/python'} 21:41:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:13 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 21:41:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:41:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:41:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41: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 21:41:16 INFO - Downloading docopt-0.6.1.tar.gz 21:41:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:41:16 INFO - Installing collected packages: blobuploader, requests, docopt 21:41:16 INFO - Running setup.py install for blobuploader 21:41:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:41:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:41:16 INFO - Running setup.py install for requests 21:41:16 INFO - Running setup.py install for docopt 21:41:16 INFO - Successfully installed blobuploader requests docopt 21:41:16 INFO - Cleaning up... 21:41:16 INFO - Return code: 0 21:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41:16 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')]} 21:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:16 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')]} 21:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:16 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:16 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 21:41:16 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 21:41:16 INFO - Using env: {'DISPLAY': ':0', 21:41:16 INFO - 'HOME': '/home/cltbld', 21:41:16 INFO - 'LANG': 'en_US.UTF-8', 21:41:16 INFO - 'LANGUAGE': 'en_US:en', 21:41:16 INFO - 'LOGNAME': 'cltbld', 21:41:16 INFO - 'MAIL': '/var/mail/cltbld', 21:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:16 INFO - 'MOZ_NO_REMOTE': '1', 21:41:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:16 INFO - 'NO_EM_RESTART': '1', 21:41:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:16 INFO - 'PWD': '/builds/slave/test', 21:41:16 INFO - 'SHELL': '/bin/bash', 21:41:16 INFO - 'SHLVL': '1', 21:41:16 INFO - 'TERM': 'linux', 21:41:16 INFO - 'TMOUT': '86400', 21:41:16 INFO - 'USER': 'cltbld', 21:41:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:16 INFO - '_': '/tools/buildbot/bin/python'} 21:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:17 INFO - Running setup.py (path:/tmp/pip-KEqEuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:17 INFO - Running setup.py (path:/tmp/pip-p7a7IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:17 INFO - Running setup.py (path:/tmp/pip-CefgGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:17 INFO - Running setup.py (path:/tmp/pip-XvfGsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:17 INFO - Running setup.py (path:/tmp/pip-EWktZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:17 INFO - Running setup.py (path:/tmp/pip-Duj7Ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:17 INFO - Running setup.py (path:/tmp/pip-_NSm2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:17 INFO - Running setup.py (path:/tmp/pip-idIxdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:17 INFO - Running setup.py (path:/tmp/pip-HpCMNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:17 INFO - Running setup.py (path:/tmp/pip-1028We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:17 INFO - Running setup.py (path:/tmp/pip-AMGezg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:17 INFO - Running setup.py (path:/tmp/pip-aQhuC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:17 INFO - Running setup.py (path:/tmp/pip-x8nIQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:17 INFO - Running setup.py (path:/tmp/pip-gznGAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:18 INFO - Running setup.py (path:/tmp/pip-w3fv_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:18 INFO - Running setup.py (path:/tmp/pip-vTwdYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:18 INFO - Running setup.py (path:/tmp/pip-rBvIuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:41:18 INFO - Running setup.py install for manifestparser 21:41:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:41:18 INFO - Running setup.py install for mozcrash 21:41:18 INFO - Running setup.py install for mozdebug 21:41:18 INFO - Running setup.py install for mozdevice 21:41:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:41:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:41:18 INFO - Running setup.py install for mozfile 21:41:18 INFO - Running setup.py install for mozhttpd 21:41:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:41:18 INFO - Running setup.py install for mozinfo 21:41:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:41:18 INFO - Running setup.py install for mozInstall 21:41:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Running setup.py install for mozleak 21:41:19 INFO - Running setup.py install for mozlog 21:41:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Running setup.py install for moznetwork 21:41:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Running setup.py install for mozprocess 21:41:19 INFO - Running setup.py install for mozprofile 21:41:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Running setup.py install for mozrunner 21:41:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Running setup.py install for mozscreenshot 21:41:19 INFO - Running setup.py install for moztest 21:41:19 INFO - Running setup.py install for mozversion 21:41:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:41:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:41:19 INFO - Cleaning up... 21:41:20 INFO - Return code: 0 21:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:20 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:20 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 21:41:20 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 21:41:20 INFO - Using env: {'DISPLAY': ':0', 21:41:20 INFO - 'HOME': '/home/cltbld', 21:41:20 INFO - 'LANG': 'en_US.UTF-8', 21:41:20 INFO - 'LANGUAGE': 'en_US:en', 21:41:20 INFO - 'LOGNAME': 'cltbld', 21:41:20 INFO - 'MAIL': '/var/mail/cltbld', 21:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:20 INFO - 'MOZ_NO_REMOTE': '1', 21:41:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:20 INFO - 'NO_EM_RESTART': '1', 21:41:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:20 INFO - 'PWD': '/builds/slave/test', 21:41:20 INFO - 'SHELL': '/bin/bash', 21:41:20 INFO - 'SHLVL': '1', 21:41:20 INFO - 'TERM': 'linux', 21:41:20 INFO - 'TMOUT': '86400', 21:41:20 INFO - 'USER': 'cltbld', 21:41:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:20 INFO - '_': '/tools/buildbot/bin/python'} 21:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:41:20 INFO - Running setup.py (path:/tmp/pip-pVQAxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:41:20 INFO - Running setup.py (path:/tmp/pip-7upwGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:41:20 INFO - Running setup.py (path:/tmp/pip-Wo0fKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:41:20 INFO - Running setup.py (path:/tmp/pip-2KUdwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:41:20 INFO - Running setup.py (path:/tmp/pip-JnYSMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:41:20 INFO - Running setup.py (path:/tmp/pip-jgMCe5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:41:20 INFO - Running setup.py (path:/tmp/pip-AeCZOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:41:20 INFO - Running setup.py (path:/tmp/pip-UY9J2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:41:20 INFO - Running setup.py (path:/tmp/pip-OXPX_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:41:20 INFO - Running setup.py (path:/tmp/pip-imIK5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:41:20 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)) 21:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:41:20 INFO - Running setup.py (path:/tmp/pip-SaIbnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:41:21 INFO - Running setup.py (path:/tmp/pip-TFvcJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:41:21 INFO - Running setup.py (path:/tmp/pip-BFs3jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:41:21 INFO - Running setup.py (path:/tmp/pip-Zu21n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:21 INFO - Running setup.py (path:/tmp/pip-56QprN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:41:21 INFO - Running setup.py (path:/tmp/pip-xCsPfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:41:21 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)) 21:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:41:21 INFO - Running setup.py (path:/tmp/pip-R76SVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:41:21 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)) 21:41:21 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)) 21:41:21 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)) 21:41:21 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)) 21:41:21 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)) 21:41:21 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)) 21:41:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:41:23 INFO - Downloading blessings-1.6.tar.gz 21:41:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:41:23 INFO - Installing collected packages: blessings 21:41:23 INFO - Running setup.py install for blessings 21:41:23 INFO - Successfully installed blessings 21:41:23 INFO - Cleaning up... 21:41:23 INFO - Return code: 0 21:41:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:41:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:23 INFO - Reading from file tmpfile_stdout 21:41:23 INFO - Current package versions: 21:41:23 INFO - argparse == 1.2.1 21:41:23 INFO - blessings == 1.6 21:41:23 INFO - blobuploader == 1.2.4 21:41:23 INFO - docopt == 0.6.1 21:41:23 INFO - functools32 == 3.2.3-2 21:41:23 INFO - jsonschema == 2.5.1 21:41:23 INFO - manifestparser == 1.1 21:41:23 INFO - mozInstall == 1.12 21:41:23 INFO - mozcrash == 0.17 21:41:23 INFO - mozdebug == 0.1 21:41:23 INFO - mozdevice == 0.48 21:41:23 INFO - mozfile == 1.2 21:41:23 INFO - mozhttpd == 0.7 21:41:23 INFO - mozinfo == 0.9 21:41:23 INFO - mozleak == 0.1 21:41:23 INFO - mozlog == 3.4 21:41:23 INFO - moznetwork == 0.27 21:41:23 INFO - mozprocess == 0.23 21:41:23 INFO - mozprofile == 0.28 21:41:23 INFO - mozrunner == 6.12 21:41:23 INFO - mozscreenshot == 0.1 21:41:23 INFO - mozsystemmonitor == 0.3 21:41:23 INFO - moztest == 0.7 21:41:23 INFO - mozversion == 1.4 21:41:23 INFO - psutil == 3.1.1 21:41:23 INFO - requests == 1.2.3 21:41:23 INFO - wsgiref == 0.1.2 21:41:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:41: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')]} 21:41:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41: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')]} 21:41:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:23 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 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:23 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 21:41:23 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 21:41:23 INFO - Using env: {'DISPLAY': ':0', 21:41:23 INFO - 'HOME': '/home/cltbld', 21:41:23 INFO - 'LANG': 'en_US.UTF-8', 21:41:23 INFO - 'LANGUAGE': 'en_US:en', 21:41:23 INFO - 'LOGNAME': 'cltbld', 21:41:23 INFO - 'MAIL': '/var/mail/cltbld', 21:41:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:23 INFO - 'MOZ_NO_REMOTE': '1', 21:41:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:23 INFO - 'NO_EM_RESTART': '1', 21:41:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:23 INFO - 'PWD': '/builds/slave/test', 21:41:23 INFO - 'SHELL': '/bin/bash', 21:41:23 INFO - 'SHLVL': '1', 21:41:23 INFO - 'TERM': 'linux', 21:41:23 INFO - 'TMOUT': '86400', 21:41:23 INFO - 'USER': 'cltbld', 21:41:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:23 INFO - '_': '/tools/buildbot/bin/python'} 21:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 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)) 21:41:24 INFO - Cleaning up... 21:41:24 INFO - Return code: 0 21:41:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:41:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f85d734df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a69ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', '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 21:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:41:24 INFO - Using env: {'DISPLAY': ':0', 21:41:24 INFO - 'HOME': '/home/cltbld', 21:41:24 INFO - 'LANG': 'en_US.UTF-8', 21:41:24 INFO - 'LANGUAGE': 'en_US:en', 21:41:24 INFO - 'LOGNAME': 'cltbld', 21:41:24 INFO - 'MAIL': '/var/mail/cltbld', 21:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:24 INFO - 'MOZ_NO_REMOTE': '1', 21:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:24 INFO - 'NO_EM_RESTART': '1', 21:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:24 INFO - 'PWD': '/builds/slave/test', 21:41:24 INFO - 'SHELL': '/bin/bash', 21:41:24 INFO - 'SHLVL': '1', 21:41:24 INFO - 'TERM': 'linux', 21:41:24 INFO - 'TMOUT': '86400', 21:41:24 INFO - 'USER': 'cltbld', 21:41:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:24 INFO - '_': '/tools/buildbot/bin/python'} 21:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:41:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:41:24 INFO - Cleaning up... 21:41:24 INFO - Return code: 0 21:41:24 INFO - Running post-action listener: _resource_record_post_action 21:41:24 INFO - Running post-action listener: _start_resource_monitoring 21:41:24 INFO - Starting resource monitoring. 21:41:24 INFO - [mozharness: 2016-10-31 04:41:24.405705Z] Finished create-virtualenv step (success) 21:41:24 INFO - [mozharness: 2016-10-31 04:41:24.406245Z] Running install step. 21:41:24 INFO - Running pre-action listener: _resource_record_pre_action 21:41:24 INFO - Running main action method: install 21:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:41:24 INFO - Reading from file tmpfile_stdout 21:41:24 INFO - Detecting whether we're running mozinstall >=1.0... 21:41:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:41:24 INFO - Reading from file tmpfile_stdout 21:41:24 INFO - Output received: 21:41:24 INFO - Usage: mozinstall [options] installer 21:41:24 INFO - Options: 21:41:24 INFO - -h, --help show this help message and exit 21:41:24 INFO - -d DEST, --destination=DEST 21:41:24 INFO - Directory to install application into. [default: 21:41:24 INFO - "/builds/slave/test"] 21:41:24 INFO - --app=APP Application being installed. [default: firefox] 21:41:24 INFO - mkdir: /builds/slave/test/build/application 21:41:24 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'] 21:41:24 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 21:41:41 INFO - Reading from file tmpfile_stdout 21:41:41 INFO - Output received: 21:41:41 INFO - /builds/slave/test/build/application/firefox/firefox 21:41:41 INFO - Running post-action listener: _resource_record_post_action 21:41:41 INFO - [mozharness: 2016-10-31 04:41:41.510703Z] Finished install step (success) 21:41:41 INFO - [mozharness: 2016-10-31 04:41:41.510948Z] Running run-tests step. 21:41:41 INFO - Running pre-action listener: _resource_record_pre_action 21:41:41 INFO - Running main action method: run_tests 21:41:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:41 INFO - Python 2.7.3 21:41:41 INFO - Return code: 0 21:41:41 INFO - grabbing minidump binary from tooltool 21:41:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:41 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 0x1a66f60>, '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 0x1a67d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a681d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:41 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 21:41:41 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 21:41:41 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 21:41:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:41 INFO - Return code: 0 21:41:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:41:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:41:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:41 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/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:41:41 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/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:41:41 INFO - Using env: {'DISPLAY': ':0', 21:41:41 INFO - 'HOME': '/home/cltbld', 21:41:41 INFO - 'LANG': 'en_US.UTF-8', 21:41:41 INFO - 'LANGUAGE': 'en_US:en', 21:41:41 INFO - 'LOGNAME': 'cltbld', 21:41:41 INFO - 'MAIL': '/var/mail/cltbld', 21:41:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:41:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:41 INFO - 'MOZ_NO_REMOTE': '1', 21:41:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:41 INFO - 'NO_EM_RESTART': '1', 21:41:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:41 INFO - 'PWD': '/builds/slave/test', 21:41:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:41 INFO - 'SHELL': '/bin/bash', 21:41:41 INFO - 'SHLVL': '1', 21:41:41 INFO - 'TERM': 'linux', 21:41:41 INFO - 'TMOUT': '86400', 21:41:41 INFO - 'USER': 'cltbld', 21:41:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074', 21:41:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:41 INFO - '_': '/tools/buildbot/bin/python'} 21:41:41 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/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:41:41 INFO - mozversion application_buildid: 20161030200921 21:41:41 INFO - mozversion application_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 21:41:41 INFO - mozversion application_display_name: Nightly 21:41:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:41 INFO - mozversion application_name: Firefox 21:41:41 INFO - mozversion application_remotingname: firefox 21:41:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:41:41 INFO - mozversion application_vendor: Mozilla 21:41:41 INFO - mozversion application_version: 52.0a1 21:41:41 INFO - mozversion platform_buildid: 20161030200921 21:41:41 INFO - mozversion platform_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 21:41:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:41:41 INFO - mozversion platform_version: 52.0a1 21:41:41 INFO - using testdate: 1477888901 21:41:41 INFO - actual date: 1477888901 21:41:41 INFO - starting webserver on 'localhost:44657' 21:41:41 INFO - SUITE-START | Running 2 tests 21:41:41 INFO - TEST-START | dromaeo_css 21:41:41 INFO - operating with platform_type : linux_ 21:41:41 INFO - Initialising browser for dromaeo_css test... 21:41:41 INFO - TEST-INFO | started process 30180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZ5V2i/profile http://localhost:44657/getInfo.html) 21:41:46 INFO - PROCESS | 30180 | __metrics Screen width/height:1600/1200 21:41:46 INFO - PROCESS | 30180 | colorDepth:24 21:41:46 INFO - PROCESS | 30180 | Browser inner width/height: 1024/697 21:41:46 INFO - PROCESS | 30180 | __metrics 21:41:46 INFO - PROCESS | 30180 | 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" 21:41:46 INFO - PROCESS | 30180 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:47 INFO - PROCESS | 30180 | console.error: PushService: 21:41:47 INFO - PROCESS | 30180 | stateChangeProcessEnqueue: Error transitioning state 21:41:47 INFO - PROCESS | 30180 | UnknownError 21:41:48 INFO - TEST-INFO | 30180: exit 0 21:41:48 INFO - Browser initialized. 21:41:48 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:48 INFO - TEST-INFO | started process 30262 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoZ5V2i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:42:00 INFO - PROCESS | 30262 | RSS: Main: 175984640 21:42:00 INFO - PROCESS | 30262 | 21:42:53 INFO - PROCESS | 30262 | 1477888973087 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] 21:45:05 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44657/tests/dromaeo/cssquery-ext.html) 21:45:06 INFO - PROCESS | 30262 | RSS: Main: 304459776 21:45:06 INFO - PROCESS | 30262 | 21:48:09 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-ext.html (next: http://localhost:44657/tests/dromaeo/cssquery-jquery.html) 21:48:10 INFO - PROCESS | 30262 | RSS: Main: 273272832 21:48:10 INFO - PROCESS | 30262 | 21:51:12 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44657/tests/dromaeo/cssquery-mootools.html) 21:51:12 INFO - PROCESS | 30262 | RSS: Main: 221872128 21:51:12 INFO - PROCESS | 30262 | 21:54:15 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44657/tests/dromaeo/cssquery-prototype.html) 21:54:15 INFO - PROCESS | 30262 | RSS: Main: 222715904 21:54:15 INFO - PROCESS | 30262 | 21:57:18 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44657/tests/dromaeo/cssquery-yui.html) 21:57:19 INFO - PROCESS | 30262 | RSS: Main: 221941760 21:57:19 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | Cycle 1(1): loaded http://localhost:44657/tests/dromaeo/cssquery-yui.html (next: http://localhost:44657/tests/dromaeo/cssquery-dojo.html) 22:00:22 INFO - PROCESS | 30262 | RSS: Main: 309723136 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | __start_tp_report 22:00:22 INFO - PROCESS | 30262 | _x_x_mozilla_page_load 22:00:22 INFO - PROCESS | 30262 | _x_x_mozilla_page_load_details 22:00:22 INFO - PROCESS | 30262 | |i|pagename|runs| 22:00:22 INFO - PROCESS | 30262 | |0;dojo.html;2525.1035882261795;2535.3027917322725;2569.2292312306304;2570.331713754423;2574.909878154264;4387.122575484907;4441.800118994645;4575.405197324343;4576.5652263035;4583.083383323336;4506.774661266932;4507.752073635948;4511.187986162489;4534.070515544314;4563.429571303587;4140.917181656365;4143.171365726852;4199.286121359376;4201.6008479194425;4279.33670281107;3548.4677298405186;4210;4250.171216612762;4251.8511852085185;4306.397104405386;4082.6733861291027;4145.2124096421885;4244.554321796213;4245.639120674747;4254.3831144483875;4138.689598280111;4140.958590414088;4163.937540936889;4189.49726032878;4198.265303571863;4108.8356465741335;4148.56440073794;4199.9790001050105;4202.3696445533415;4218.957810421887;4533.637309015271;4539.205639013159;4578.404807375054;4616.492185859553;4619.445666520039;4737.218358970766;4798.280257961299;4802.5197480252045;4854.12625727369;4862.78117484714;4841.273808928654;4849.3453383793085;4870.172070747982;4871.4154301483695;4933.383327084114;4525.818967241339;4552.408186935677;4554.88612784683;4560.270356742905;4608.170529304757;4858.295547145644;4878.170710979142;4909.95090049095;4913.31213630092;4915.48387419323;4720.763961801965;4725;4732.550407711262;4759.4764575896625;4787.186178349689;4809.687370320918;4811.133995880705;4811.663183577186;4813.518648135228;4864.051509955595;4717.740524271198;4765.046990601893;4779.880502987453;4780.784864681098;4832.975835120872;4812.663113582085;4818.590419814355;4821.831235906797;4889.046635905964;4898.90202195954;4125.071858831799;4130.814113364906;4131.710780245414;4134.627883490501;4178.561251068655;3561.198730285665;3667.6149004354693;3690.022144131807;3693.169036966715;3705.27747089315;4079.592040795956;4139.482564679415;4191.538930717618;4233.407322974786;4238.957610423856;4892.923626672542;4903.583195428358;4911.705297682151;4913;4952.083864485082;4190.392393102983;4225.683073769418;4228.682848786353;4243.681723870722;4276.1661476012505;4296.140771845643;4337.50118736343;4346.956530434719;4362.76004819738;4411.977940110279;4593.242115050979;4594.050704337824;4595.494495605548;4638.420197475383;4647.604953578849;4873.342098816614;4874.90250194987;4876.878078048077;4924.433690125681;4935.136351138464;4478.171538265431;4499;4533.048059907456;4579.954200458086;4594.402727645384;4739.786709598007;4754.334393185026;4755.548222918817;4796.880077998078;4815.085133824562;4809.711417314972;4821.662483626253;4824.49342818999;4824.589909857701;4885.975570122127;4591.265397536378;4642.280446530793;4682.789274482725;4701.623870090316;4753.477117517001;4704.741239231875;4719.457262414866;4749.620030397491;4750.429948406213;4811.807527698853;4681.602063824613;4688.882777930579;4693.225617773166;4706.952930470651;4755.286706993978;4637.86086417408;4779.808807647655;4786.976065119652;4787.8563643090765;4850.1997170466475;4587.059652771107;4598.793054312497;4614.353990441274;4635.953640463687;4685.648576356855 22:00:22 INFO - PROCESS | 30262 | |1;ext.html;545.5553723715173;553.8587660146661;557.6737608499028;560.5011539729638;567.1917517537509;28396;30510.694893051063;39089.80455097728;40457.59542404575;40517.39223911644;40283.79858100705;40669;40712.59287407125;40763.18473630526;40824.79587602058;7627.542347459143;7688.961555192216;7696.037995250594;7701.537907725555;7740.225977402271;7280.781576552686;7476.588787616679;7609.505382150142;9661.323707340489;10057.849132263022;9954.054364835365;10014.749631259205;10018.448985305842;10025.44860032698;10038.146757525583;9933.106020458157;10001.349912255753;10002.749931251705;10003.849557300859;10009.499525023792;9916.25628077897;9974.650887218984;9983.500824958795;9984.25118116137;9998.850017249748;37405;37672.24655506902;37690.81154594237;37698.81150594229;37739.62260377389;2694.407230409307;2761.8619069046667;2916.8687409066642;3526.8589256429714;3660.4692319613505;27537.311567210778;28303.716962830313;28338.433231335464;28789.856050719613;31462.370752585048;3454.5854497460464;3519.085037890167;3526.894193174209;3552.1652411683235;3578.427451607756;250127;250933;252608;252810;252894;52477;52666.47002064805;53049.46950530523;53089.73455132777;53459.19811202835;31363;32062.679373206436;32203.51694724534;34126.31747365089;56366.436335636936;13117.08180427361;13263.933680331536;13306.13510121839;13318.733625327439;13328.533501327407;9370.250379969586;10359;10428.113610343205;10439.164866810637;10442.68671939843;14911.403543858125;16900.83099169017;17389.304427822997;17521.211545480484;17806.91096544535;6590.406863382319;6654.86690266192;6670.266270710218;6742.707479457008;6766.6278354689985;790.8576456237932;885.0839381240386;934.425328423015;954.2080073538946;968.5738275158908;26506;26778.196654100408;26885.193444196706;27414.5887811683;27589.86205068962;922.7554698005034;940.9717708468756;943.2265542255421;966.2849491376331;983.2920297385871;13699.863001369858;14465.349059292146;14520.854791452162;14666.266686665624;14798.408063677547;382162;384773;386303;386578;387174;46966;47476.5252347479;47480.76259618749;47507.524924751;47610.285845712344;1040.9635662751768;1098.6484325015917;1173.1553281637207;1180.2328486483855;1201.9819702704642;26376.736232638195;27171.32071698144;28437.715622843505;28959.42081158323;29197.562036569892;38415.42376864293;38803.223935521695;38890.80554597209;38910.61089389183;38943.610563894;289342;291336;291496;292056;292177;21832;22297.554048918606;22402.663960040285;22597.548049039255;22651.20720774765;39873.80063099666;40050.39924401078;40081;40578;41412.378814318414;33847;34059;34138.14654633654;34522;34701;34213.31573368568;34344.82827585946;34350.31299374049;34525.30949380948;34853;34386.82806585951;34468.31063378769;34662.30675386428;34893.825530872185;34995;29284.560731588615;31541.842290788398;31550.684493154775;31667.683323167395;31786.682133179296;24598.50802983966;24606.75393246116;24609.63085553754;24875.378115547257;25018.3745406359 22:00:22 INFO - PROCESS | 30262 | |2;jquery.html;339.01169640061016;359.6223964836922;365.82074783356154;369.87424275746247;393.93303138466456;12554.121211515198;12985.48058077677;17354.962881495718;17507.73738393922;17778.555536111602;16975.57561060974;17028.829711702878;17398.21708023139;17445.563860903483;17572.472825815214;4830.420349558058;4892.070506603752;4937.777999900041;4949.331840201581;5061.974690126544;4848.442429120661;4941.160002799515;4956.2070068789;4957.851264462072;4959.280904268879;4842.66101372904;5112;5129.2306154077;5173.094708426029;5190.92213616796;5073.239014147871;5114.718690472023;5143.742812859342;5151.896962060775;5157.7936882524655;4993.825216117419;5010.774515146827;5013.1227035268685;5013.323201367842;5020.1214787412055;11171.16216283782;11333.376664283462;11376.146788990858;17772.91113544424;20601.793982060288;1735.3232239426634;1812.7009043507805;1830.1855674224976;1860.4325680667391;1941.6990366493217;8604.139586041409;9001.50491722955;9535.855697316298;11839.585614503538;13358.39887205078;1629.8370162983726;1631.4126914310839;1648.5219286406927;1682.537302241881;1694.4493039762126;62029.6898515509;67641;68251.65874170647;68930;70287.64856175789;9774.511274436392;9979.700608981597;9991.000899910096;10038.648647297456;10214.846777298346;10379.532921018572;13681.04232703721;13698.452061917611;13699.315034248248;13724.382402791898;6534.705938232696;6614.371634694697;6851.520393572402;6863.38229559342;6884.759033433906;6492.740290388331;6558.442532384801;6578.671066446658;6727.66361681914;6781.355771201728;3476.3047390521997;3611.368010598135;3731.421629647409;3817.2938006468894;3818.0836599215986;1702.9063401512788;1790.2698384963035;1799.3162598212596;1843.4101087651823;1859.9163037663338;797.1908512859452;813.6419975210888;816.1389733830747;819.2626636027622;824.221111050052;16210.351585936667;16594.58513537147;16781;16920.66158676844;17076.743848842278;832.7376876283951;835.7409203147043;857.1300130367682;886.1935638568872;890.4167770110588;9199.172074513326;9307.348485605942;9651.131398174199;9692.273079518924;9881.555330010167;361811;362949;363109;371350;375419;73111.63444182745;74117;74622.25377746261;75396.62301688457;75831;916.2212119698203;918.6968300460832;938.4134915677702;939.5396255834592;947.2327414794039;14550.41798328055;14639;14821.851781482048;14952.775708364601;15297.311620977305;32871.506927396586;34092.488612670335;34910.301793963474;35442;35642;44031.559684402746;50085.49914500954;50492.24261636005;50722.239166413274;53216.73391633017;5907.3797251288;6260.561760676709;7236.6019868907715;7454.44091693136;7681.577513236825;10199.184065274909;11060.336379817236;11257.549698011988;11533.826992595286;11833.526658933546;10036.297459177787;10040.64857729976;10131.949340253546;10331.948340258552;10465.424401657981;9176.724698259062;10026.949865250626;10140.13808826258;10156.18750499973;10214.591416343263;9661.855072174063;10051.195904327782;10099.44453055089;10232.079112879877;10346.633677689235;7365.594892280976;7399.334059934632;7524.984127142766;7531.623418828927;7542.396608271435;8837.381383303107;9707.563159657691;9720.222382209266;9879.654212102541;10178.134858537107 22:00:22 INFO - PROCESS | 30262 | |3;mootools.html;1227.9263244205354;1316.6510874618227;1362.972740545189;1376.5732622886906;1607.7025750236207;6084.330723620398;6672;6944.51388402812;6951.652417379136;7124.251953544881;6984.546004509703;7051.0833591633145;7054.858902821953;7057.505974581782;7060.046893669353;2076.4497408186844;2104.568563444498;2104.9368518944457;2106.810387065164;2117.9894100529477;2054.563156953522;2100.338393406072;2107.3361891004283;2119.629064913634;2125.946851328714;2042.2647846775149;2060.1141509151057;2077.7091207231;2084.395525297662;2086.2176683743596;1976.743023406955;2027.7363942687357;2028.9086991085437;2029.340464349085;2029.5940811837545;2026.4629873083645;2040.653088974863;2071.2647010311275;2073.512724509739;2073.6060148571723;6743.35938085881;6869.107016087926;6903.861922761567;6920.584764914071;7019.929800701979;4251.426057482262;4363.040131171138;4374.0595771908875;4374.103308821684;4377.25586650267;2593.5461294273427;2759.9172024839286;2807.2420446479337;2819;2820.3372207531215;903.3001758901354;913.3195769151957;925.9444433333954;928.5867788833972;948.4878165790465;9217.170454659046;9234.07659234078;9244.676436324764;9287.164155226063;9291;3506.3688536063755;3696.075981004749;3741.794201318899;3769.962300377016;3777.263433630416;7424.703011879572;7432.702691892264;7435.51669141504;7438.033055702832;7444.106707195063;4232.576742325743;4234.026173980002;4235.97882010588;4236.703430759879;4237.322028475429;3424.195314101184;3472.7742696725136;3545.4150065239464;3821.293060783764;3872.477215575861;2914.4753944290233;3019.5390756533357;3230.095573239497;3245;3247.272291275293;944.15026476172;969.6363863551169;979.1187930862138;980.4313498171043;984.5618699678718;719.1945021575868;781.2109769133103;795.7692269241855;804.3364224514798;807.1524898856295;4556.157110934488;4573.49691533931;4588.334691469719;4662.580367766917;4783.378160839138;386.1581751781144;397.52098721041074;399.245426144587;399.5485101834966;405.8640355480947;3230.5638738769967;3238.8542515586855;3240.3195328980705;3282.2778988622463;3354.59744830617;8055.355571554262;8544.359173062045;8553.059163492011;8554.23011928917;8556.700515481929;8486.32109431244;8488.618012189467;8489.957550212333;8494.447860889022;8495.957520212483;6636.701348439332;6708.698108585126;6730.360615741497;6730.899036514456;6732.966335168391;4563.954360456486;4574.6569007323915;4644.187267228154;4679.602233810028;4834.8791280216865;7257.2742725727;7449.702011919462;7471.40228781707;7478.5138965967035;7533.434992375484;7167.534110282815;7362.668679909524;7383.264932740909;7437.888431673421;7592.354649854824;6604.933950660624;6707.765228216989;6746.4265537429865;6763.797086087426;6765.797026089225;6699.732010719516;6755.7973260802255;6807.863842723217;6810.693518791567;6810.978353246855;5924.851878703067;5997.340292567901;6060.454559089527;6148.292946311231;6267.2479302484;5941.31674857397;5975.342712301556;6056.3035250946705;6059.6364218147055;6186.81439556814;5441.5102640762525;5505.256790333414;5516.062269414129;5634.267545219095;5714.342850572238;3874.2251549689613;3922.803859806941;3956.8021598919363;3986.621270979252;4126.752394856198;3948.1511475033008;3960.9405858911564;3993.8602148924647;4050.1292222172374;4081.571449992479 22:00:22 INFO - PROCESS | 30262 | |4;prototype.html;285.7371218478999;286.99569506457397;294.5684572101871;296.5462841851967;299.87705040933224;4640.535946405366;4800.519948005198;4811.735354555498;4815.32749324125;4848.927266091007;4596.816127354902;4684.742339171353;4697.953020469794;4743.027679325739;4779.665423420362;3799.544054713438;3813.7521061130938;3813.828377723009;3821.6942644588366;3821.7324787264834;3548;3805.219929914361;3812.618738126179;3813.752106113108;3818.3508803503473;3377.560917080776;3573.0888623401124;3736.9813150934206;3746.4193050077283;3754.1177823211524;3675.1547144156725;3721.32064913262;3740.083679498513;3741.8690345837763;3744.8876533704033;3315.4529502632035;3322.0731975454178;3324.7672662913606;3326.76712630116;3329.1344250494803;4498.122866041123;4643.955110100234;4646.372739680134;4647.814087436498;4689.624830013625;4287.8070486828165;4288.335308027261;4294.227039132955;4305.311150215982;4309.922519370158;4967.801287948478;4970.676906001098;4971.90056198874;4982.377202849644;4983.576396006344;3343.3981883261004;3648.4858783604773;3656.524651795276;3658.9268214635827;3664;5157.200633901752;5195.766190521435;5214.2960700304975;5221.71280579568;5228.163493840967;3578.7852728835833;3579.0336609115393;3599.262151258986;3607.7113830893463;3612.584552776412;3642.7996460194945;3643.4352675334835;3652.817359132033;3654.1595433050547;3656.012876523324;3954.7824869632445;4121.237571049365;4157.605027522381;4187.811548480326;4193.916121677549;4983.352164218629;4988.152014157602;4988.90022199554;5000.67495612784;5005.599552035828;1204.6145233525363;1228.6928267933017;1230.7169351049129;1268.6003908768707;1274.5156840400589;856.9957150214334;878.4729162502448;883.4169448164181;886;887.8313120507083;4400.405945197422;4406.413691071211;4420.336949457543;4425.668074894395;4437.934895625027;4892.315075889378;5109.744512774347;5118.283440318359;5129.487051294841;5132.178851383761;4370.132432796998;4389.18800021997;4391.890202744957;4393.3085761981865;4396.340548917688;2393.7247216569967;2401.6517604947185;2416.903323867026;2424.2363655448476;2428.7734693979783;4261.592200406761;4279.97860010698;4289.935650965238;4303.634191093792;4310.224159651293;4411.382406463098;4592.494825569184;4595.2188128018315;4601.999999999933;4626.398568186114;4246.745195288293;4251;4286.81372500021;4292.484901811803;4303.397524346594;4447.687932060115;4470.262406702857;4500.3249512573375;4509;4527.773611319487;4260.467441569804;4451.3545535896465;4471.278557755222;4477.798499067485;4496.6177874879695;4277.251480990752;4280;4280.764557949218;4283.378910058086;4291.283486605258;3252.577164968539;3257.853396597206;3262.9117364886965;3267.624223214361;3275.263065810269;4284.271673815521;4487.730736155841;4498.415206023196;4528.977355113203;4545.477270113979;4306.698531102793;4337.503561271356;4340.782960851881;4362.345648152803;4424.623906967944;4350.695451318377;4375.287321860467;4378.737275763465;4409.977950110229;4426.889327766831;4362.716423432466;4702.811887524597;4834.806607735792;4886.29148773433;4902.3872015998;4919.557239848287;4967.776450059684;4976.676516026447;5033.094043072282;5048.217526283432;4893.90212195747;4901.950980490149;4902.093112774148;4907.533784290486;4924.685397862999 22:00:22 INFO - PROCESS | 30262 | |5;yui.html;653.4119292636628;654.4796886475252;698.6402002968468;726.8437285983513;749.6364263332283;12416.441260143292;13246.801297980537;13286.800697989514;13313.933430332834;13349.532766353179;11714.414279286022;11804.173707840455;11826.645200643994;11828.704282392944;11844.644660660173;609.1989034419746;630.5239544144165;757.9507332023401;782.9960850195741;789.8894154818302;791.3234184772024;800.7117437722416;801.070757920812;801.3028665061405;801.767487428645;847.2798121596655;849.7365816596874;850.0691742541907;850.1540966738104;850.5237067242364;625.2559454249451;658.789187460013;661.6526323680058;663.9734410623569;841.5161282262693;488.6994498383504;585.9179714839884;608.6621924831717;614.0758158970765;616.4759954039076;11179;11180.105591552656;11197.776044479146;11206.607768728138;11320.377379244139;11881.168318217728;12041.277523348626;12283.201591896499;12379.071569632313;12437.689057773629;11012.119030477543;11020.944895275472;11024.944875275653;11343.546258149665;11433.371164585944;3927.214557088565;3972.443857859902;4002.8198731057173;4110.23960567296;4118.835246590133;45672.3149152763;45897.770511147566;46704;46780.29829552525;47124.057518849775;9547.42715437076;9739.805203895883;9884.061014203638;9934.552945117342;10206.285560010729;17560.38538651141;17630.82369176292;17848.821511784976;17929.282828686708;17985.640287194183;6391.840203994937;6465.709043093072;6499.772507962199;6538.738450461929;6816.250212476623;3372.713319367881;3404.1659793350786;3411.6588341165684;3419.1793969447153;3522.172289511963;2550.145701190085;2626.6060090986507;2628.934276643061;2633.7761290290155;2634.617980392871;469.67123013889733;472.86286976776347;476.9070031343924;477.2411865134453;477.5439455320161;532.174155235692;532.4037078472136;547.4443439908496;560.3555910702725;576.7779404929048;6936.4797640177185;7000.649967501605;7131.358177764027;7272.60000699956;7299.4160467163565;539.3958766181902;540.7188262103763;555.6999220421009;560.369584217755;567.1974156568492;3374.4094783412806;3498.3877821381157;3562.8040457774555;3572.5534308211472;3575.1419659281587;55584.72207638936;57442.7127864358;57763;63602.36397636057;68158;35213.64786352104;54981.900361993336;56569.7171514148;57407.13889291664;57974.71012644994;50645.746771265905;53306.73346633242;54669;55216;55889;8374.623141958504;8680.956595217236;8801.955990220007;8840.469571825712;8860.202581767671;36334.27331453409;36933.261334772615;37051;37127.62872371242;38034;45045;47753;50189.49810501994;50915;53809.46190538201;10106.14097801695;10378.221633377678;10535.367877927349;10625.574977000833;10755.408452534874;11531.135164862837;11929.46317415701;11953.342566158944;12162.148649594797;12217.511299548274;7850.921490785019;11163.832542511705;11323.207375483636;11670.591529296435;11858.584949526725;10103.393796372242;10265.794684106128;10465.319754215952;10564.577416903237;10999.23005389647;10147.949260253652;10397;10427.635032773816;10513.264071514921;10922.672319830417;9407.165602707406;9440.669576564787;9851.211903047595;9925.255605829736;10149.883512813733;9773.804523909625;9932.553035113582;10108.595656173964;10191.337563058378;10219.335743176669 22:00:22 INFO - PROCESS | 30262 | __end_tp_report 22:00:22 INFO - PROCESS | 30262 | __start_cc_report 22:00:22 INFO - PROCESS | 30262 | _x_x_mozilla_cycle_collect,1323 22:00:22 INFO - PROCESS | 30262 | __end_cc_report 22:00:22 INFO - PROCESS | 30262 | __startTimestamp1477890022759__endTimestamp 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | ------- Summary: start ------- 22:00:22 INFO - PROCESS | 30262 | Number of tests: 6 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#0] dojo.html Cycles:165 Average:4484.67 Median:4598.79 stddev:462.05 (10.0%) stddev-sans-first:437.15 22:00:22 INFO - PROCESS | 30262 | Values: 2525.1 2535.3 2569.2 2570.3 2574.9 4387.1 4441.8 4575.4 4576.6 4583.1 4506.8 4507.8 4511.2 4534.1 4563.4 4140.9 4143.2 4199.3 4201.6 4279.3 3548.5 4210.0 4250.2 4251.9 4306.4 4082.7 4145.2 4244.6 4245.6 4254.4 4138.7 4141.0 4163.9 4189.5 4198.3 4108.8 4148.6 4200.0 4202.4 4219.0 4533.6 4539.2 4578.4 4616.5 4619.4 4737.2 4798.3 4802.5 4854.1 4862.8 4841.3 4849.3 4870.2 4871.4 4933.4 4525.8 4552.4 4554.9 4560.3 4608.2 4858.3 4878.2 4910.0 4913.3 4915.5 4720.8 4725.0 4732.6 4759.5 4787.2 4809.7 4811.1 4811.7 4813.5 4864.1 4717.7 4765.0 4779.9 4780.8 4833.0 4812.7 4818.6 4821.8 4889.0 4898.9 4125.1 4130.8 4131.7 4134.6 4178.6 3561.2 3667.6 3690.0 3693.2 3705.3 4079.6 4139.5 4191.5 4233.4 4239.0 4892.9 4903.6 4911.7 4913.0 4952.1 4190.4 4225.7 4228.7 4243.7 4276.2 4296.1 4337.5 4347.0 4362.8 4412.0 4593.2 4594.1 4595.5 4638.4 4647.6 4873.3 4874.9 4876.9 4924.4 4935.1 4478.2 4499.0 4533.0 4580.0 4594.4 4739.8 4754.3 4755.5 4796.9 4815.1 4809.7 4821.7 4824.5 4824.6 4886.0 4591.3 4642.3 4682.8 4701.6 4753.5 4704.7 4719.5 4749.6 4750.4 4811.8 4681.6 4688.9 4693.2 4707.0 4755.3 4637.9 4779.8 4787.0 4787.9 4850.2 4587.1 4598.8 4614.4 4636.0 4685.6 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#1] ext.html Cycles:180 Average:45632.96 Median:34523.65 stddev:82756.48 (239.7%) stddev-sans-first:82919.39 22:00:22 INFO - PROCESS | 30262 | Values: 545.6 553.9 557.7 560.5 567.2 28396.0 30510.7 39089.8 40457.6 40517.4 40283.8 40669.0 40712.6 40763.2 40824.8 7627.5 7689.0 7696.0 7701.5 7740.2 7280.8 7476.6 7609.5 9661.3 10057.8 9954.1 10014.7 10018.4 10025.4 10038.1 9933.1 10001.3 10002.7 10003.8 10009.5 9916.3 9974.7 9983.5 9984.3 9998.9 37405.0 37672.2 37690.8 37698.8 37739.6 2694.4 2761.9 2916.9 3526.9 3660.5 27537.3 28303.7 28338.4 28789.9 31462.4 3454.6 3519.1 3526.9 3552.2 3578.4 250127.0 250933.0 252608.0 252810.0 252894.0 52477.0 52666.5 53049.5 53089.7 53459.2 31363.0 32062.7 32203.5 34126.3 56366.4 13117.1 13263.9 13306.1 13318.7 13328.5 9370.3 10359.0 10428.1 10439.2 10442.7 14911.4 16900.8 17389.3 17521.2 17806.9 6590.4 6654.9 6670.3 6742.7 6766.6 790.9 885.1 934.4 954.2 968.6 26506.0 26778.2 26885.2 27414.6 27589.9 922.8 941.0 943.2 966.3 983.3 13699.9 14465.3 14520.9 14666.3 14798.4 382162.0 384773.0 386303.0 386578.0 387174.0 46966.0 47476.5 47480.8 47507.5 47610.3 1041.0 1098.6 1173.2 1180.2 1202.0 26376.7 27171.3 28437.7 28959.4 29197.6 38415.4 38803.2 38890.8 38910.6 38943.6 289342.0 291336.0 291496.0 292056.0 292177.0 21832.0 22297.6 22402.7 22597.5 22651.2 39873.8 40050.4 40081.0 40578.0 41412.4 33847.0 34059.0 34138.1 34522.0 34701.0 34213.3 34344.8 34350.3 34525.3 34853.0 34386.8 34468.3 34662.3 34893.8 34995.0 29284.6 31541.8 31550.7 31667.7 31786.7 24598.5 24606.8 24609.6 24875.4 25018.4 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#2] jquery.html Cycles:180 Average:23087.12 Median:4845.55 stddev:60697.97 (1252.7%) stddev-sans-first:60844.21 22:00:22 INFO - PROCESS | 30262 | Values: 339.0 359.6 365.8 369.9 393.9 12554.1 12985.5 17355.0 17507.7 17778.6 16975.6 17028.8 17398.2 17445.6 17572.5 4830.4 4892.1 4937.8 4949.3 5062.0 4848.4 4941.2 4956.2 4957.9 4959.3 4842.7 5112.0 5129.2 5173.1 5190.9 5073.2 5114.7 5143.7 5151.9 5157.8 4993.8 5010.8 5013.1 5013.3 5020.1 11171.2 11333.4 11376.1 17772.9 20601.8 1735.3 1812.7 1830.2 1860.4 1941.7 8604.1 9001.5 9535.9 11839.6 13358.4 1629.8 1631.4 1648.5 1682.5 1694.4 62029.7 67641.0 68251.7 68930.0 70287.6 9774.5 9979.7 9991.0 10038.6 10214.8 10379.5 13681.0 13698.5 13699.3 13724.4 6534.7 6614.4 6851.5 6863.4 6884.8 6492.7 6558.4 6578.7 6727.7 6781.4 3476.3 3611.4 3731.4 3817.3 3818.1 1702.9 1790.3 1799.3 1843.4 1859.9 797.2 813.6 816.1 819.3 824.2 16210.4 16594.6 16781.0 16920.7 17076.7 832.7 835.7 857.1 886.2 890.4 9199.2 9307.3 9651.1 9692.3 9881.6 361811.0 362949.0 363109.0 371350.0 375419.0 73111.6 74117.0 74622.3 75396.6 75831.0 916.2 918.7 938.4 939.5 947.2 14550.4 14639.0 14821.9 14952.8 15297.3 32871.5 34092.5 34910.3 35442.0 35642.0 44031.6 50085.5 50492.2 50722.2 53216.7 5907.4 6260.6 7236.6 7454.4 7681.6 10199.2 11060.3 11257.5 11533.8 11833.5 10036.3 10040.6 10131.9 10331.9 10465.4 9176.7 10026.9 10140.1 10156.2 10214.6 9661.9 10051.2 10099.4 10232.1 10346.6 7365.6 7399.3 7525.0 7531.6 7542.4 8837.4 9707.6 9720.2 9879.7 10178.1 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#3] mootools.html Cycles:180 Average:4560.61 Median:5473.38 stddev:2489.57 (45.5%) stddev-sans-first:2483.96 22:00:22 INFO - PROCESS | 30262 | Values: 1227.9 1316.7 1363.0 1376.6 1607.7 6084.3 6672.0 6944.5 6951.7 7124.3 6984.5 7051.1 7054.9 7057.5 7060.0 2076.4 2104.6 2104.9 2106.8 2118.0 2054.6 2100.3 2107.3 2119.6 2125.9 2042.3 2060.1 2077.7 2084.4 2086.2 1976.7 2027.7 2028.9 2029.3 2029.6 2026.5 2040.7 2071.3 2073.5 2073.6 6743.4 6869.1 6903.9 6920.6 7019.9 4251.4 4363.0 4374.1 4374.1 4377.3 2593.5 2759.9 2807.2 2819.0 2820.3 903.3 913.3 925.9 928.6 948.5 9217.2 9234.1 9244.7 9287.2 9291.0 3506.4 3696.1 3741.8 3770.0 3777.3 7424.7 7432.7 7435.5 7438.0 7444.1 4232.6 4234.0 4236.0 4236.7 4237.3 3424.2 3472.8 3545.4 3821.3 3872.5 2914.5 3019.5 3230.1 3245.0 3247.3 944.2 969.6 979.1 980.4 984.6 719.2 781.2 795.8 804.3 807.2 4556.2 4573.5 4588.3 4662.6 4783.4 386.2 397.5 399.2 399.5 405.9 3230.6 3238.9 3240.3 3282.3 3354.6 8055.4 8544.4 8553.1 8554.2 8556.7 8486.3 8488.6 8490.0 8494.4 8496.0 6636.7 6708.7 6730.4 6730.9 6733.0 4564.0 4574.7 4644.2 4679.6 4834.9 7257.3 7449.7 7471.4 7478.5 7533.4 7167.5 7362.7 7383.3 7437.9 7592.4 6604.9 6707.8 6746.4 6763.8 6765.8 6699.7 6755.8 6807.9 6810.7 6811.0 5924.9 5997.3 6060.5 6148.3 6267.2 5941.3 5975.3 6056.3 6059.6 6186.8 5441.5 5505.3 5516.1 5634.3 5714.3 3874.2 3922.8 3956.8 3986.6 4126.8 3948.2 3960.9 3993.9 4050.1 4081.6 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#4] prototype.html Cycles:180 Average:3970.90 Median:4356.52 stddev:1130.84 (26.0%) stddev-sans-first:1099.67 22:00:22 INFO - PROCESS | 30262 | Values: 285.7 287.0 294.6 296.5 299.9 4640.5 4800.5 4811.7 4815.3 4848.9 4596.8 4684.7 4698.0 4743.0 4779.7 3799.5 3813.8 3813.8 3821.7 3821.7 3548.0 3805.2 3812.6 3813.8 3818.4 3377.6 3573.1 3737.0 3746.4 3754.1 3675.2 3721.3 3740.1 3741.9 3744.9 3315.5 3322.1 3324.8 3326.8 3329.1 4498.1 4644.0 4646.4 4647.8 4689.6 4287.8 4288.3 4294.2 4305.3 4309.9 4967.8 4970.7 4971.9 4982.4 4983.6 3343.4 3648.5 3656.5 3658.9 3664.0 5157.2 5195.8 5214.3 5221.7 5228.2 3578.8 3579.0 3599.3 3607.7 3612.6 3642.8 3643.4 3652.8 3654.2 3656.0 3954.8 4121.2 4157.6 4187.8 4193.9 4983.4 4988.2 4988.9 5000.7 5005.6 1204.6 1228.7 1230.7 1268.6 1274.5 857.0 878.5 883.4 886.0 887.8 4400.4 4406.4 4420.3 4425.7 4437.9 4892.3 5109.7 5118.3 5129.5 5132.2 4370.1 4389.2 4391.9 4393.3 4396.3 2393.7 2401.7 2416.9 2424.2 2428.8 4261.6 4280.0 4289.9 4303.6 4310.2 4411.4 4592.5 4595.2 4602.0 4626.4 4246.7 4251.0 4286.8 4292.5 4303.4 4447.7 4470.3 4500.3 4509.0 4527.8 4260.5 4451.4 4471.3 4477.8 4496.6 4277.3 4280.0 4280.8 4283.4 4291.3 3252.6 3257.9 3262.9 3267.6 3275.3 4284.3 4487.7 4498.4 4529.0 4545.5 4306.7 4337.5 4340.8 4362.3 4424.6 4350.7 4375.3 4378.7 4410.0 4426.9 4362.7 4702.8 4834.8 4886.3 4902.4 4919.6 4967.8 4976.7 5033.1 5048.2 4893.9 4902.0 4902.1 4907.5 4924.7 22:00:22 INFO - PROCESS | 30262 | 22:00:22 INFO - PROCESS | 30262 | [#5] yui.html Cycles:180 Average:13971.57 Median:23796.86 stddev:17144.44 (72.0%) stddev-sans-first:17163.37 22:00:22 INFO - PROCESS | 30262 | Values: 653.4 654.5 698.6 726.8 749.6 12416.4 13246.8 13286.8 13313.9 13349.5 11714.4 11804.2 11826.6 11828.7 11844.6 609.2 630.5 758.0 783.0 789.9 791.3 800.7 801.1 801.3 801.8 847.3 849.7 850.1 850.2 850.5 625.3 658.8 661.7 664.0 841.5 488.7 585.9 608.7 614.1 616.5 11179.0 11180.1 11197.8 11206.6 11320.4 11881.2 12041.3 12283.2 12379.1 12437.7 11012.1 11020.9 11024.9 11343.5 11433.4 3927.2 3972.4 4002.8 4110.2 4118.8 45672.3 45897.8 46704.0 46780.3 47124.1 9547.4 9739.8 9884.1 9934.6 10206.3 17560.4 17630.8 17848.8 17929.3 17985.6 6391.8 6465.7 6499.8 6538.7 6816.3 3372.7 3404.2 3411.7 3419.2 3522.2 2550.1 2626.6 2628.9 2633.8 2634.6 469.7 472.9 476.9 477.2 477.5 532.2 532.4 547.4 560.4 576.8 6936.5 7000.6 7131.4 7272.6 7299.4 539.4 540.7 555.7 560.4 567.2 3374.4 3498.4 3562.8 3572.6 3575.1 55584.7 57442.7 57763.0 63602.4 68158.0 35213.6 54981.9 56569.7 57407.1 57974.7 50645.7 53306.7 54669.0 55216.0 55889.0 8374.6 8681.0 8802.0 8840.5 8860.2 36334.3 36933.3 37051.0 37127.6 38034.0 45045.0 47753.0 50189.5 50915.0 53809.5 10106.1 10378.2 10535.4 10625.6 10755.4 11531.1 11929.5 11953.3 12162.1 12217.5 7850.9 11163.8 11323.2 11670.6 11858.6 10103.4 10265.8 10465.3 10564.6 10999.2 10147.9 10397.0 10427.6 10513.3 10922.7 9407.2 9440.7 9851.2 9925.3 10149.9 9773.8 9932.6 10108.6 10191.3 10219.3 22:00:22 INFO - PROCESS | 30262 | -------- Summary: end -------- 22:00:22 INFO - PROCESS | 30262 | 22:00:23 INFO - TEST-INFO | 30262: exit 0 22:00:23 INFO - TEST-OK | dromaeo_css | took 1121935ms 22:00:23 INFO - TEST-START | kraken 22:00:23 INFO - operating with platform_type : linux_ 22:00:23 INFO - Initialising browser for kraken test... 22:00:23 INFO - TEST-INFO | started process 30563 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjRYz2w/profile http://localhost:44657/getInfo.html) 22:00:28 INFO - PROCESS | 30563 | __metrics Screen width/height:1600/1200 22:00:28 INFO - PROCESS | 30563 | colorDepth:24 22:00:28 INFO - PROCESS | 30563 | Browser inner width/height: 1024/697 22:00:28 INFO - PROCESS | 30563 | __metrics 22:00:28 INFO - PROCESS | 30563 | 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" 22:00:28 INFO - PROCESS | 30563 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:29 INFO - PROCESS | 30563 | console.error: PushService: 22:00:29 INFO - PROCESS | 30563 | stateChangeProcessEnqueue: Error transitioning state 22:00:29 INFO - PROCESS | 30563 | UnknownError 22:00:30 INFO - TEST-INFO | 30563: exit 0 22:00:30 INFO - Browser initialized. 22:00:30 INFO - Running cycle 1/1 for kraken test... 22:00:30 INFO - TEST-INFO | started process 30645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjRYz2w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:42 INFO - PROCESS | 30645 | RSS: Main: 176381952 22:00:42 INFO - PROCESS | 30645 | 22:00:45 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44657/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:46 INFO - PROCESS | 30645 | RSS: Main: 236429312 22:00:46 INFO - PROCESS | 30645 | 22:00:49 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44657/tests/kraken/driver.html?testName=audio-dft) 22:00:49 INFO - PROCESS | 30645 | RSS: Main: 219385856 22:00:49 INFO - PROCESS | 30645 | 22:00:52 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44657/tests/kraken/driver.html?testName=audio-fft) 22:00:53 INFO - PROCESS | 30645 | RSS: Main: 301481984 22:00:53 INFO - PROCESS | 30645 | 22:00:55 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44657/tests/kraken/driver.html?testName=audio-oscillator) 22:00:56 INFO - PROCESS | 30645 | RSS: Main: 212443136 22:00:56 INFO - PROCESS | 30645 | 22:00:58 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:59 INFO - PROCESS | 30645 | RSS: Main: 214798336 22:00:59 INFO - PROCESS | 30645 | 22:01:02 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44657/tests/kraken/driver.html?testName=imaging-darkroom) 22:01:02 INFO - PROCESS | 30645 | RSS: Main: 251564032 22:01:02 INFO - PROCESS | 30645 | 22:01:06 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44657/tests/kraken/driver.html?testName=imaging-desaturate) 22:01:07 INFO - PROCESS | 30645 | RSS: Main: 250548224 22:01:07 INFO - PROCESS | 30645 | 22:01:09 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44657/tests/kraken/driver.html?testName=json-parse-financial) 22:01:10 INFO - PROCESS | 30645 | RSS: Main: 250212352 22:01:10 INFO - PROCESS | 30645 | 22:01:12 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:01:12 INFO - PROCESS | 30645 | RSS: Main: 212336640 22:01:12 INFO - PROCESS | 30645 | 22:01:14 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:01:15 INFO - PROCESS | 30645 | RSS: Main: 219836416 22:01:15 INFO - PROCESS | 30645 | 22:01:17 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:01:17 INFO - PROCESS | 30645 | RSS: Main: 228700160 22:01:17 INFO - PROCESS | 30645 | 22:01:20 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:01:21 INFO - PROCESS | 30645 | RSS: Main: 237613056 22:01:21 INFO - PROCESS | 30645 | 22:01:24 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:01:25 INFO - PROCESS | 30645 | RSS: Main: 233734144 22:01:25 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | Cycle 1(1): loaded http://localhost:44657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44657/tests/kraken/driver.html?testName=ai-astar) 22:01:27 INFO - PROCESS | 30645 | RSS: Main: 284864512 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | __start_tp_report 22:01:27 INFO - PROCESS | 30645 | _x_x_mozilla_page_load 22:01:27 INFO - PROCESS | 30645 | _x_x_mozilla_page_load_details 22:01:27 INFO - PROCESS | 30645 | |i|pagename|runs| 22:01:27 INFO - PROCESS | 30645 | |0;ai-astar;107;117;118;115;118;115;115;115;116;115 22:01:27 INFO - PROCESS | 30645 | |1;audio-beat-detection;153;138;129;166;137;130;127;134;169;130 22:01:27 INFO - PROCESS | 30645 | |2;audio-dft;160;160;161;163;161;161;162;161;161;160 22:01:27 INFO - PROCESS | 30645 | |3;audio-fft;77;77;77;105;76;77;77;76;103;76 22:01:27 INFO - PROCESS | 30645 | |4;audio-oscillator;83;83;121;83;85;89;114;83;84;119 22:01:27 INFO - PROCESS | 30645 | |5;imaging-gaussian-blur;116;117;116;117;117;117;117;117;117;118 22:01:27 INFO - PROCESS | 30645 | |6;imaging-darkroom;147;146;146;146;146;146;147;147;146;146 22:01:27 INFO - PROCESS | 30645 | |7;imaging-desaturate;85;84;84;84;85;84;85;84;85;84 22:01:27 INFO - PROCESS | 30645 | |8;json-parse-financial;64;63;63;63;63;65;65;65;63;63 22:01:27 INFO - PROCESS | 30645 | |9;json-stringify-tinderbox;66;66;67;67;67;66;66;66;69;67 22:01:27 INFO - PROCESS | 30645 | |10;stanford-crypto-aes;85;84;84;83;84;83;93;83;83;88 22:01:27 INFO - PROCESS | 30645 | |11;stanford-crypto-ccm;144;141;147;147;141;149;144;141;190;143 22:01:27 INFO - PROCESS | 30645 | |12;stanford-crypto-pbkdf2;177;183;182;176;176;184;180;177;181;178 22:01:27 INFO - PROCESS | 30645 | |13;stanford-crypto-sha256-iterative;69;70;72;73;70;70;69;70;70;67 22:01:27 INFO - PROCESS | 30645 | __end_tp_report 22:01:27 INFO - PROCESS | 30645 | __start_cc_report 22:01:27 INFO - PROCESS | 30645 | _x_x_mozilla_cycle_collect,1953 22:01:27 INFO - PROCESS | 30645 | __end_cc_report 22:01:27 INFO - PROCESS | 30645 | __startTimestamp1477890087275__endTimestamp 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | ------- Summary: start ------- 22:01:27 INFO - PROCESS | 30645 | Number of tests: 14 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#0] ai-astar Cycles:10 Average:115.10 Median:115.50 stddev:3.11 (2.7%) stddev-sans-first:1.32 22:01:27 INFO - PROCESS | 30645 | Values: 107.0 117.0 118.0 115.0 118.0 115.0 115.0 115.0 116.0 115.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:137.50 stddev:15.66 (11.4%) stddev-sans-first:16.03 22:01:27 INFO - PROCESS | 30645 | Values: 153.0 138.0 129.0 166.0 137.0 130.0 127.0 134.0 169.0 130.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 22:01:27 INFO - PROCESS | 30645 | Values: 160.0 160.0 161.0 163.0 161.0 161.0 162.0 161.0 161.0 160.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:11.56 (15.0%) stddev-sans-first:12.11 22:01:27 INFO - PROCESS | 30645 | Values: 77.0 77.0 77.0 105.0 76.0 77.0 77.0 76.0 103.0 76.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:16.47 (19.8%) stddev-sans-first:16.95 22:01:27 INFO - PROCESS | 30645 | Values: 83.0 83.0 121.0 83.0 85.0 89.0 114.0 83.0 84.0 119.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 22:01:27 INFO - PROCESS | 30645 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 22:01:27 INFO - PROCESS | 30645 | Values: 147.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 22:01:27 INFO - PROCESS | 30645 | Values: 85.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 85.0 84.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:63.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 22:01:27 INFO - PROCESS | 30645 | Values: 64.0 63.0 63.0 63.0 63.0 65.0 65.0 65.0 63.0 63.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:0.97 22:01:27 INFO - PROCESS | 30645 | Values: 66.0 66.0 67.0 67.0 67.0 66.0 66.0 66.0 69.0 67.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:84.00 stddev:3.20 (3.8%) stddev-sans-first:3.39 22:01:27 INFO - PROCESS | 30645 | Values: 85.0 84.0 84.0 83.0 84.0 83.0 93.0 83.0 83.0 88.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:145.50 stddev:14.78 (10.2%) stddev-sans-first:15.58 22:01:27 INFO - PROCESS | 30645 | Values: 144.0 141.0 147.0 147.0 141.0 149.0 144.0 141.0 190.0 143.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:180.50 stddev:2.99 (1.7%) stddev-sans-first:3.04 22:01:27 INFO - PROCESS | 30645 | Values: 177.0 183.0 182.0 176.0 176.0 184.0 180.0 177.0 181.0 178.0 22:01:27 INFO - PROCESS | 30645 | 22:01:27 INFO - PROCESS | 30645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.63 (2.3%) stddev-sans-first:1.69 22:01:27 INFO - PROCESS | 30645 | Values: 69.0 70.0 72.0 73.0 70.0 70.0 69.0 70.0 70.0 67.0 22:01:27 INFO - PROCESS | 30645 | -------- Summary: end -------- 22:01:27 INFO - PROCESS | 30645 | 22:01:28 INFO - TEST-INFO | 30645: exit 0 22:01:28 INFO - TEST-OK | kraken | took 64942ms 22:01:28 INFO - SUITE-END | took 1186s 22:01:28 INFO - Completed test suite (00:19:47) 22:01:28 INFO - javascript benchmark 22:01:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2525.1035882261795, 2535.3027917322725, 2569.2292312306304, 2570.331713754423, 2574.909878154264, 4387.122575484907, 4441.800118994645, 4575.405197324343, 4576.5652263035, 4583.083383323336, 4506.774661266932, 4507.752073635948, 4511.187986162489, 4534.070515544314, 4563.429571303587, 4140.917181656365, 4143.171365726852, 4199.286121359376, 4201.6008479194425, 4279.33670281107, 3548.4677298405186, 4210.0, 4250.171216612762, 4251.8511852085185, 4306.397104405386, 4082.6733861291027, 4145.2124096421885, 4244.554321796213, 4245.639120674747, 4254.3831144483875, 4138.689598280111, 4140.958590414088, 4163.937540936889, 4189.49726032878, 4198.265303571863, 4108.8356465741335, 4148.56440073794, 4199.9790001050105, 4202.3696445533415, 4218.957810421887, 4533.637309015271, 4539.205639013159, 4578.404807375054, 4616.492185859553, 4619.445666520039, 4737.218358970766, 4798.280257961299, 4802.5197480252045, 4854.12625727369, 4862.78117484714, 4841.273808928654, 4849.3453383793085, 4870.172070747982, 4871.4154301483695, 4933.383327084114, 4525.818967241339, 4552.408186935677, 4554.88612784683, 4560.270356742905, 4608.170529304757, 4858.295547145644, 4878.170710979142, 4909.95090049095, 4913.31213630092, 4915.48387419323, 4720.763961801965, 4725.0, 4732.550407711262, 4759.4764575896625, 4787.186178349689, 4809.687370320918, 4811.133995880705, 4811.663183577186, 4813.518648135228, 4864.051509955595, 4717.740524271198, 4765.046990601893, 4779.880502987453, 4780.784864681098, 4832.975835120872, 4812.663113582085, 4818.590419814355, 4821.831235906797, 4889.046635905964, 4898.90202195954, 4125.071858831799, 4130.814113364906, 4131.710780245414, 4134.627883490501, 4178.561251068655, 3561.198730285665, 3667.6149004354693, 3690.022144131807, 3693.169036966715, 3705.27747089315, 4079.592040795956, 4139.482564679415, 4191.538930717618, 4233.407322974786, 4238.957610423856, 4892.923626672542, 4903.583195428358, 4911.705297682151, 4913.0, 4952.083864485082, 4190.392393102983, 4225.683073769418, 4228.682848786353, 4243.681723870722, 4276.1661476012505, 4296.140771845643, 4337.50118736343, 4346.956530434719, 4362.76004819738, 4411.977940110279, 4593.242115050979, 4594.050704337824, 4595.494495605548, 4638.420197475383, 4647.604953578849, 4873.342098816614, 4874.90250194987, 4876.878078048077, 4924.433690125681, 4935.136351138464, 4478.171538265431, 4499.0, 4533.048059907456, 4579.954200458086, 4594.402727645384, 4739.786709598007, 4754.334393185026, 4755.548222918817, 4796.880077998078, 4815.085133824562, 4809.711417314972, 4821.662483626253, 4824.49342818999, 4824.589909857701, 4885.975570122127, 4591.265397536378, 4642.280446530793, 4682.789274482725, 4701.623870090316, 4753.477117517001, 4704.741239231875, 4719.457262414866, 4749.620030397491, 4750.429948406213, 4811.807527698853, 4681.602063824613, 4688.882777930579, 4693.225617773166, 4706.952930470651, 4755.286706993978, 4637.86086417408, 4779.808807647655, 4786.976065119652, 4787.8563643090765, 4850.1997170466475, 4587.059652771107, 4598.793054312497, 4614.353990441274, 4635.953640463687, 4685.648576356855], "value": 4455.975685936719, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5553723715173, 553.8587660146661, 557.6737608499028, 560.5011539729638, 567.1917517537509, 28396.0, 30510.694893051063, 39089.80455097728, 40457.59542404575, 40517.39223911644, 40283.79858100705, 40669.0, 40712.59287407125, 40763.18473630526, 40824.79587602058, 7627.542347459143, 7688.961555192216, 7696.037995250594, 7701.537907725555, 7740.225977402271, 7280.781576552686, 7476.588787616679, 7609.505382150142, 9661.323707340489, 10057.849132263022, 9954.054364835365, 10014.749631259205, 10018.448985305842, 10025.44860032698, 10038.146757525583, 9933.106020458157, 10001.349912255753, 10002.749931251705, 10003.849557300859, 10009.499525023792, 9916.25628077897, 9974.650887218984, 9983.500824958795, 9984.25118116137, 9998.850017249748, 37405.0, 37672.24655506902, 37690.81154594237, 37698.81150594229, 37739.62260377389, 2694.407230409307, 2761.8619069046667, 2916.8687409066642, 3526.8589256429714, 3660.4692319613505, 27537.311567210778, 28303.716962830313, 28338.433231335464, 28789.856050719613, 31462.370752585048, 3454.5854497460464, 3519.085037890167, 3526.894193174209, 3552.1652411683235, 3578.427451607756, 250127.0, 250933.0, 252608.0, 252810.0, 252894.0, 52477.0, 52666.47002064805, 53049.46950530523, 53089.73455132777, 53459.19811202835, 31363.0, 32062.679373206436, 32203.51694724534, 34126.31747365089, 56366.436335636936, 13117.08180427361, 13263.933680331536, 13306.13510121839, 13318.733625327439, 13328.533501327407, 9370.250379969586, 10359.0, 10428.113610343205, 10439.164866810637, 10442.68671939843, 14911.403543858125, 16900.83099169017, 17389.304427822997, 17521.211545480484, 17806.91096544535, 6590.406863382319, 6654.86690266192, 6670.266270710218, 6742.707479457008, 6766.6278354689985, 790.8576456237932, 885.0839381240386, 934.425328423015, 954.2080073538946, 968.5738275158908, 26506.0, 26778.196654100408, 26885.193444196706, 27414.5887811683, 27589.86205068962, 922.7554698005034, 940.9717708468756, 943.2265542255421, 966.2849491376331, 983.2920297385871, 13699.863001369858, 14465.349059292146, 14520.854791452162, 14666.266686665624, 14798.408063677547, 382162.0, 384773.0, 386303.0, 386578.0, 387174.0, 46966.0, 47476.5252347479, 47480.76259618749, 47507.524924751, 47610.285845712344, 1040.9635662751768, 1098.6484325015917, 1173.1553281637207, 1180.2328486483855, 1201.9819702704642, 26376.736232638195, 27171.32071698144, 28437.715622843505, 28959.42081158323, 29197.562036569892, 38415.42376864293, 38803.223935521695, 38890.80554597209, 38910.61089389183, 38943.610563894, 289342.0, 291336.0, 291496.0, 292056.0, 292177.0, 21832.0, 22297.554048918606, 22402.663960040285, 22597.548049039255, 22651.20720774765, 39873.80063099666, 40050.39924401078, 40081.0, 40578.0, 41412.378814318414, 33847.0, 34059.0, 34138.14654633654, 34522.0, 34701.0, 34213.31573368568, 34344.82827585946, 34350.31299374049, 34525.30949380948, 34853.0, 34386.82806585951, 34468.31063378769, 34662.30675386428, 34893.825530872185, 34995.0, 29284.560731588615, 31541.842290788398, 31550.684493154775, 31667.683323167395, 31786.682133179296, 24598.50802983966, 24606.75393246116, 24609.63085553754, 24875.378115547257, 25018.3745406359], "value": 17199.986354478016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.01169640061016, 359.6223964836922, 365.82074783356154, 369.87424275746247, 393.93303138466456, 12554.121211515198, 12985.48058077677, 17354.962881495718, 17507.73738393922, 17778.555536111602, 16975.57561060974, 17028.829711702878, 17398.21708023139, 17445.563860903483, 17572.472825815214, 4830.420349558058, 4892.070506603752, 4937.777999900041, 4949.331840201581, 5061.974690126544, 4848.442429120661, 4941.160002799515, 4956.2070068789, 4957.851264462072, 4959.280904268879, 4842.66101372904, 5112.0, 5129.2306154077, 5173.094708426029, 5190.92213616796, 5073.239014147871, 5114.718690472023, 5143.742812859342, 5151.896962060775, 5157.7936882524655, 4993.825216117419, 5010.774515146827, 5013.1227035268685, 5013.323201367842, 5020.1214787412055, 11171.16216283782, 11333.376664283462, 11376.146788990858, 17772.91113544424, 20601.793982060288, 1735.3232239426634, 1812.7009043507805, 1830.1855674224976, 1860.4325680667391, 1941.6990366493217, 8604.139586041409, 9001.50491722955, 9535.855697316298, 11839.585614503538, 13358.39887205078, 1629.8370162983726, 1631.4126914310839, 1648.5219286406927, 1682.537302241881, 1694.4493039762126, 62029.6898515509, 67641.0, 68251.65874170647, 68930.0, 70287.64856175789, 9774.511274436392, 9979.700608981597, 9991.000899910096, 10038.648647297456, 10214.846777298346, 10379.532921018572, 13681.04232703721, 13698.452061917611, 13699.315034248248, 13724.382402791898, 6534.705938232696, 6614.371634694697, 6851.520393572402, 6863.38229559342, 6884.759033433906, 6492.740290388331, 6558.442532384801, 6578.671066446658, 6727.66361681914, 6781.355771201728, 3476.3047390521997, 3611.368010598135, 3731.421629647409, 3817.2938006468894, 3818.0836599215986, 1702.9063401512788, 1790.2698384963035, 1799.3162598212596, 1843.4101087651823, 1859.9163037663338, 797.1908512859452, 813.6419975210888, 816.1389733830747, 819.2626636027622, 824.221111050052, 16210.351585936667, 16594.58513537147, 16781.0, 16920.66158676844, 17076.743848842278, 832.7376876283951, 835.7409203147043, 857.1300130367682, 886.1935638568872, 890.4167770110588, 9199.172074513326, 9307.348485605942, 9651.131398174199, 9692.273079518924, 9881.555330010167, 361811.0, 362949.0, 363109.0, 371350.0, 375419.0, 73111.63444182745, 74117.0, 74622.25377746261, 75396.62301688457, 75831.0, 916.2212119698203, 918.6968300460832, 938.4134915677702, 939.5396255834592, 947.2327414794039, 14550.41798328055, 14639.0, 14821.851781482048, 14952.775708364601, 15297.311620977305, 32871.506927396586, 34092.488612670335, 34910.301793963474, 35442.0, 35642.0, 44031.559684402746, 50085.49914500954, 50492.24261636005, 50722.239166413274, 53216.73391633017, 5907.3797251288, 6260.561760676709, 7236.6019868907715, 7454.44091693136, 7681.577513236825, 10199.184065274909, 11060.336379817236, 11257.549698011988, 11533.826992595286, 11833.526658933546, 10036.297459177787, 10040.64857729976, 10131.949340253546, 10331.948340258552, 10465.424401657981, 9176.724698259062, 10026.949865250626, 10140.13808826258, 10156.18750499973, 10214.591416343263, 9661.855072174063, 10051.195904327782, 10099.44453055089, 10232.079112879877, 10346.633677689235, 7365.594892280976, 7399.334059934632, 7524.984127142766, 7531.623418828927, 7542.396608271435, 8837.381383303107, 9707.563159657691, 9720.222382209266, 9879.654212102541, 10178.134858537107], "value": 7841.65504528882, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.9263244205354, 1316.6510874618227, 1362.972740545189, 1376.5732622886906, 1607.7025750236207, 6084.330723620398, 6672.0, 6944.51388402812, 6951.652417379136, 7124.251953544881, 6984.546004509703, 7051.0833591633145, 7054.858902821953, 7057.505974581782, 7060.046893669353, 2076.4497408186844, 2104.568563444498, 2104.9368518944457, 2106.810387065164, 2117.9894100529477, 2054.563156953522, 2100.338393406072, 2107.3361891004283, 2119.629064913634, 2125.946851328714, 2042.2647846775149, 2060.1141509151057, 2077.7091207231, 2084.395525297662, 2086.2176683743596, 1976.743023406955, 2027.7363942687357, 2028.9086991085437, 2029.340464349085, 2029.5940811837545, 2026.4629873083645, 2040.653088974863, 2071.2647010311275, 2073.512724509739, 2073.6060148571723, 6743.35938085881, 6869.107016087926, 6903.861922761567, 6920.584764914071, 7019.929800701979, 4251.426057482262, 4363.040131171138, 4374.0595771908875, 4374.103308821684, 4377.25586650267, 2593.5461294273427, 2759.9172024839286, 2807.2420446479337, 2819.0, 2820.3372207531215, 903.3001758901354, 913.3195769151957, 925.9444433333954, 928.5867788833972, 948.4878165790465, 9217.170454659046, 9234.07659234078, 9244.676436324764, 9287.164155226063, 9291.0, 3506.3688536063755, 3696.075981004749, 3741.794201318899, 3769.962300377016, 3777.263433630416, 7424.703011879572, 7432.702691892264, 7435.51669141504, 7438.033055702832, 7444.106707195063, 4232.576742325743, 4234.026173980002, 4235.97882010588, 4236.703430759879, 4237.322028475429, 3424.195314101184, 3472.7742696725136, 3545.4150065239464, 3821.293060783764, 3872.477215575861, 2914.4753944290233, 3019.5390756533357, 3230.095573239497, 3245.0, 3247.272291275293, 944.15026476172, 969.6363863551169, 979.1187930862138, 980.4313498171043, 984.5618699678718, 719.1945021575868, 781.2109769133103, 795.7692269241855, 804.3364224514798, 807.1524898856295, 4556.157110934488, 4573.49691533931, 4588.334691469719, 4662.580367766917, 4783.378160839138, 386.1581751781144, 397.52098721041074, 399.245426144587, 399.5485101834966, 405.8640355480947, 3230.5638738769967, 3238.8542515586855, 3240.3195328980705, 3282.2778988622463, 3354.59744830617, 8055.355571554262, 8544.359173062045, 8553.059163492011, 8554.23011928917, 8556.700515481929, 8486.32109431244, 8488.618012189467, 8489.957550212333, 8494.447860889022, 8495.957520212483, 6636.701348439332, 6708.698108585126, 6730.360615741497, 6730.899036514456, 6732.966335168391, 4563.954360456486, 4574.6569007323915, 4644.187267228154, 4679.602233810028, 4834.8791280216865, 7257.2742725727, 7449.702011919462, 7471.40228781707, 7478.5138965967035, 7533.434992375484, 7167.534110282815, 7362.668679909524, 7383.264932740909, 7437.888431673421, 7592.354649854824, 6604.933950660624, 6707.765228216989, 6746.4265537429865, 6763.797086087426, 6765.797026089225, 6699.732010719516, 6755.7973260802255, 6807.863842723217, 6810.693518791567, 6810.978353246855, 5924.851878703067, 5997.340292567901, 6060.454559089527, 6148.292946311231, 6267.2479302484, 5941.31674857397, 5975.342712301556, 6056.3035250946705, 6059.6364218147055, 6186.81439556814, 5441.5102640762525, 5505.256790333414, 5516.062269414129, 5634.267545219095, 5714.342850572238, 3874.2251549689613, 3922.803859806941, 3956.8021598919363, 3986.621270979252, 4126.752394856198, 3948.1511475033008, 3960.9405858911564, 3993.8602148924647, 4050.1292222172374, 4081.571449992479], "value": 3661.294348446621, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.7371218478999, 286.99569506457397, 294.5684572101871, 296.5462841851967, 299.87705040933224, 4640.535946405366, 4800.519948005198, 4811.735354555498, 4815.32749324125, 4848.927266091007, 4596.816127354902, 4684.742339171353, 4697.953020469794, 4743.027679325739, 4779.665423420362, 3799.544054713438, 3813.7521061130938, 3813.828377723009, 3821.6942644588366, 3821.7324787264834, 3548.0, 3805.219929914361, 3812.618738126179, 3813.752106113108, 3818.3508803503473, 3377.560917080776, 3573.0888623401124, 3736.9813150934206, 3746.4193050077283, 3754.1177823211524, 3675.1547144156725, 3721.32064913262, 3740.083679498513, 3741.8690345837763, 3744.8876533704033, 3315.4529502632035, 3322.0731975454178, 3324.7672662913606, 3326.76712630116, 3329.1344250494803, 4498.122866041123, 4643.955110100234, 4646.372739680134, 4647.814087436498, 4689.624830013625, 4287.8070486828165, 4288.335308027261, 4294.227039132955, 4305.311150215982, 4309.922519370158, 4967.801287948478, 4970.676906001098, 4971.90056198874, 4982.377202849644, 4983.576396006344, 3343.3981883261004, 3648.4858783604773, 3656.524651795276, 3658.9268214635827, 3664.0, 5157.200633901752, 5195.766190521435, 5214.2960700304975, 5221.71280579568, 5228.163493840967, 3578.7852728835833, 3579.0336609115393, 3599.262151258986, 3607.7113830893463, 3612.584552776412, 3642.7996460194945, 3643.4352675334835, 3652.817359132033, 3654.1595433050547, 3656.012876523324, 3954.7824869632445, 4121.237571049365, 4157.605027522381, 4187.811548480326, 4193.916121677549, 4983.352164218629, 4988.152014157602, 4988.90022199554, 5000.67495612784, 5005.599552035828, 1204.6145233525363, 1228.6928267933017, 1230.7169351049129, 1268.6003908768707, 1274.5156840400589, 856.9957150214334, 878.4729162502448, 883.4169448164181, 886.0, 887.8313120507083, 4400.405945197422, 4406.413691071211, 4420.336949457543, 4425.668074894395, 4437.934895625027, 4892.315075889378, 5109.744512774347, 5118.283440318359, 5129.487051294841, 5132.178851383761, 4370.132432796998, 4389.18800021997, 4391.890202744957, 4393.3085761981865, 4396.340548917688, 2393.7247216569967, 2401.6517604947185, 2416.903323867026, 2424.2363655448476, 2428.7734693979783, 4261.592200406761, 4279.97860010698, 4289.935650965238, 4303.634191093792, 4310.224159651293, 4411.382406463098, 4592.494825569184, 4595.2188128018315, 4601.999999999933, 4626.398568186114, 4246.745195288293, 4251.0, 4286.81372500021, 4292.484901811803, 4303.397524346594, 4447.687932060115, 4470.262406702857, 4500.3249512573375, 4509.0, 4527.773611319487, 4260.467441569804, 4451.3545535896465, 4471.278557755222, 4477.798499067485, 4496.6177874879695, 4277.251480990752, 4280.0, 4280.764557949218, 4283.378910058086, 4291.283486605258, 3252.577164968539, 3257.853396597206, 3262.9117364886965, 3267.624223214361, 3275.263065810269, 4284.271673815521, 4487.730736155841, 4498.415206023196, 4528.977355113203, 4545.477270113979, 4306.698531102793, 4337.503561271356, 4340.782960851881, 4362.345648152803, 4424.623906967944, 4350.695451318377, 4375.287321860467, 4378.737275763465, 4409.977950110229, 4426.889327766831, 4362.716423432466, 4702.811887524597, 4834.806607735792, 4886.29148773433, 4902.3872015998, 4919.557239848287, 4967.776450059684, 4976.676516026447, 5033.094043072282, 5048.217526283432, 4893.90212195747, 4901.950980490149, 4902.093112774148, 4907.533784290486, 4924.685397862999], "value": 3617.9783498470965, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.4119292636628, 654.4796886475252, 698.6402002968468, 726.8437285983513, 749.6364263332283, 12416.441260143292, 13246.801297980537, 13286.800697989514, 13313.933430332834, 13349.532766353179, 11714.414279286022, 11804.173707840455, 11826.645200643994, 11828.704282392944, 11844.644660660173, 609.1989034419746, 630.5239544144165, 757.9507332023401, 782.9960850195741, 789.8894154818302, 791.3234184772024, 800.7117437722416, 801.070757920812, 801.3028665061405, 801.767487428645, 847.2798121596655, 849.7365816596874, 850.0691742541907, 850.1540966738104, 850.5237067242364, 625.2559454249451, 658.789187460013, 661.6526323680058, 663.9734410623569, 841.5161282262693, 488.6994498383504, 585.9179714839884, 608.6621924831717, 614.0758158970765, 616.4759954039076, 11179.0, 11180.105591552656, 11197.776044479146, 11206.607768728138, 11320.377379244139, 11881.168318217728, 12041.277523348626, 12283.201591896499, 12379.071569632313, 12437.689057773629, 11012.119030477543, 11020.944895275472, 11024.944875275653, 11343.546258149665, 11433.371164585944, 3927.214557088565, 3972.443857859902, 4002.8198731057173, 4110.23960567296, 4118.835246590133, 45672.3149152763, 45897.770511147566, 46704.0, 46780.29829552525, 47124.057518849775, 9547.42715437076, 9739.805203895883, 9884.061014203638, 9934.552945117342, 10206.285560010729, 17560.38538651141, 17630.82369176292, 17848.821511784976, 17929.282828686708, 17985.640287194183, 6391.840203994937, 6465.709043093072, 6499.772507962199, 6538.738450461929, 6816.250212476623, 3372.713319367881, 3404.1659793350786, 3411.6588341165684, 3419.1793969447153, 3522.172289511963, 2550.145701190085, 2626.6060090986507, 2628.934276643061, 2633.7761290290155, 2634.617980392871, 469.67123013889733, 472.86286976776347, 476.9070031343924, 477.2411865134453, 477.5439455320161, 532.174155235692, 532.4037078472136, 547.4443439908496, 560.3555910702725, 576.7779404929048, 6936.4797640177185, 7000.649967501605, 7131.358177764027, 7272.60000699956, 7299.4160467163565, 539.3958766181902, 540.7188262103763, 555.6999220421009, 560.369584217755, 567.1974156568492, 3374.4094783412806, 3498.3877821381157, 3562.8040457774555, 3572.5534308211472, 3575.1419659281587, 55584.72207638936, 57442.7127864358, 57763.0, 63602.36397636057, 68158.0, 35213.64786352104, 54981.900361993336, 56569.7171514148, 57407.13889291664, 57974.71012644994, 50645.746771265905, 53306.73346633242, 54669.0, 55216.0, 55889.0, 8374.623141958504, 8680.956595217236, 8801.955990220007, 8840.469571825712, 8860.202581767671, 36334.27331453409, 36933.261334772615, 37051.0, 37127.62872371242, 38034.0, 45045.0, 47753.0, 50189.49810501994, 50915.0, 53809.46190538201, 10106.14097801695, 10378.221633377678, 10535.367877927349, 10625.574977000833, 10755.408452534874, 11531.135164862837, 11929.46317415701, 11953.342566158944, 12162.148649594797, 12217.511299548274, 7850.921490785019, 11163.832542511705, 11323.207375483636, 11670.591529296435, 11858.584949526725, 10103.393796372242, 10265.794684106128, 10465.319754215952, 10564.577416903237, 10999.23005389647, 10147.949260253652, 10397.0, 10427.635032773816, 10513.264071514921, 10922.672319830417, 9407.165602707406, 9440.669576564787, 9851.211903047595, 9925.255605829736, 10149.883512813733, 9773.804523909625, 9932.553035113582, 10108.595656173964, 10191.337563058378, 10219.335743176669], "value": 5977.493445263437, "unit": "score"}], "name": "dromaeo_css", "value": 6019.944441785985, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 118.0, 115.0, 118.0, 115.0, 115.0, 115.0, 116.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 138.0, 129.0, 166.0, 137.0, 130.0, 127.0, 134.0, 169.0, 130.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 163.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 105.0, 76.0, 77.0, 77.0, 76.0, 103.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 83.0, 85.0, 89.0, 114.0, 83.0, 84.0, 119.0], "value": 94.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 63.0, 63.0, 63.0, 65.0, 65.0, 65.0, 63.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 69.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 83.0, 84.0, 83.0, 93.0, 83.0, 83.0, 88.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 141.0, 147.0, 147.0, 141.0, 149.0, 144.0, 141.0, 190.0, 143.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 183.0, 182.0, 176.0, 176.0, 184.0, 180.0, 177.0, 181.0, 178.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 73.0, 70.0, 70.0, 69.0, 70.0, 70.0, 67.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1555.0, "alertThreshold": 2.0}]} 22:01:28 INFO - Return code: 0 22:01:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:01:29 INFO - # TBPL SUCCESS # 22:01:29 INFO - Running post-action listener: _resource_record_post_action 22:01:29 INFO - [mozharness: 2016-10-31 05:01:29.059923Z] Finished run-tests step (success) 22:01:29 INFO - Running post-run listener: _resource_record_post_run 22:01:29 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402681856; Read time: 12; Write time: 299000 22:01:29 INFO - TinderboxPrint: CPU usage
13.1% 22:01:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 22:01:29 INFO - TinderboxPrint: I/O write bytes / time
402,681,856 / 299,000 22:01:29 INFO - TinderboxPrint: CPU idle
8,345.2 (86.9%) 22:01:29 INFO - TinderboxPrint: CPU user
1,208.8 (12.6%) 22:01:29 INFO - TinderboxPrint: Swap in / out
0 / 0 22:01:29 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99991552; Read time: 0; Write time: 89652 22:01:29 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290590720; Read time: 0; Write time: 206708 22:01:29 INFO - Running post-run listener: _upload_blobber_files 22:01:29 INFO - Blob upload gear active. 22:01:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:01:29 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 22:01:29 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'] 22:01:29 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 22:01:30 INFO - (blobuploader) - INFO - Open directory for files ... 22:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:01:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:31 INFO - (blobuploader) - INFO - Done attempting. 22:01:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:01:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:01:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:34 INFO - (blobuploader) - INFO - Done attempting. 22:01:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:01:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:01:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:01:35 INFO - (blobuploader) - INFO - Done attempting. 22:01:35 INFO - (blobuploader) - INFO - Iteration through files over. 22:01:35 INFO - Return code: 0 22:01:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:01:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:01:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd169ed5bbcb64b802d5cd9a8ff1fd6b26fa2441e7494c6de5f3ea9a9dfefb4c2ca2cae6ffbf976807952ffc064b0f3855e52b18895217f77cafdbe9e52027eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e17a450db9da9a2af374e87ae2000292dd4fb9c96ffe0eff52bd87f4abdc05b26496fc9de350d4f1ba4aa845776df7384f9ce86ccfe8bd2704c10d6b5c697bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1870c7a86c2d22893920e6c29ba588aba902de332e51b02fa1d9b15af69b21ba046b1cd31db23d0311762ded144cde7909fe2f1edd96a17c772f6cbc6c84628e"} 22:01:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:01:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:01:35 INFO - Contents: 22:01:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/dd169ed5bbcb64b802d5cd9a8ff1fd6b26fa2441e7494c6de5f3ea9a9dfefb4c2ca2cae6ffbf976807952ffc064b0f3855e52b18895217f77cafdbe9e52027eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e17a450db9da9a2af374e87ae2000292dd4fb9c96ffe0eff52bd87f4abdc05b26496fc9de350d4f1ba4aa845776df7384f9ce86ccfe8bd2704c10d6b5c697bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1870c7a86c2d22893920e6c29ba588aba902de332e51b02fa1d9b15af69b21ba046b1cd31db23d0311762ded144cde7909fe2f1edd96a17c772f6cbc6c84628e"} 22:01:35 INFO - Running post-run listener: copy_logs_to_upload_dir 22:01:35 INFO - Copying logs to upload dir... 22:01:35 INFO - mkdir: /builds/slave/test/build/upload/logs 22:01:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.421709 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-10-30 22:01:34.892505) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 22:01:34.895807) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 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/dd169ed5bbcb64b802d5cd9a8ff1fd6b26fa2441e7494c6de5f3ea9a9dfefb4c2ca2cae6ffbf976807952ffc064b0f3855e52b18895217f77cafdbe9e52027eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e17a450db9da9a2af374e87ae2000292dd4fb9c96ffe0eff52bd87f4abdc05b26496fc9de350d4f1ba4aa845776df7384f9ce86ccfe8bd2704c10d6b5c697bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1870c7a86c2d22893920e6c29ba588aba902de332e51b02fa1d9b15af69b21ba046b1cd31db23d0311762ded144cde7909fe2f1edd96a17c772f6cbc6c84628e"} build_url:https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/bayT1pehQPulqgn0BJeq7g/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/dd169ed5bbcb64b802d5cd9a8ff1fd6b26fa2441e7494c6de5f3ea9a9dfefb4c2ca2cae6ffbf976807952ffc064b0f3855e52b18895217f77cafdbe9e52027eb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1e17a450db9da9a2af374e87ae2000292dd4fb9c96ffe0eff52bd87f4abdc05b26496fc9de350d4f1ba4aa845776df7384f9ce86ccfe8bd2704c10d6b5c697bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1870c7a86c2d22893920e6c29ba588aba902de332e51b02fa1d9b15af69b21ba046b1cd31db23d0311762ded144cde7909fe2f1edd96a17c772f6cbc6c84628e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 22:01:34.921684) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 22:01:34.922025) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1477888577.322648-33463074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 22:01:35.006457) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 22:01:35.006871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 22:01:35.007272) ========= ========= Total master_lag: 0.16 =========