builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-042 starttime: 1477868738.29 results: success (0) buildid: 20161030123004 builduid: fde67ece1338478497d193b84281b7f8 revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.288375) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.288866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.289319) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.305886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.306523) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-30 16:05:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.8M=0s 2016-10-30 16:05:38 (37.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.088486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.410820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.411264) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017792 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:38.461421) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 16:05:38.461778) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e3279760cd977aac30bd9e8032d3ee71f55d2a67 --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 e3279760cd977aac30bd9e8032d3ee71f55d2a67 --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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-30 16:05:38,639 truncating revision to first 12 chars 2016-10-30 16:05:38,639 Setting DEBUG logging. 2016-10-30 16:05:38,639 attempt 1/10 2016-10-30 16:05:38,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e3279760cd97?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 16:05:39,898 unpacking tar archive at: fx-team-e3279760cd97/testing/mozharness/ program finished with exit code 0 elapsedTime=1.585345 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 16:05:40.062020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:40.062397) ========= script_repo_revision: e3279760cd977aac30bd9e8032d3ee71f55d2a67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:40.062805) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:40.063081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 16:05:40.073345) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-30 16:05:40.073743) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:05:40 INFO - MultiFileLogger online at 20161030 16:05:40 in /builds/slave/test 16:05:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:05:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:05:40 INFO - {'append_to_log': False, 16:05:40 INFO - 'base_work_dir': '/builds/slave/test', 16:05:40 INFO - 'blob_upload_branch': 'Fx-Team', 16:05:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:05:40 INFO - 'branch': 'Fx-Team', 16:05:40 INFO - 'buildbot_json_path': 'buildprops.json', 16:05:40 INFO - 'config_files': ('talos/linux_config.py',), 16:05:40 INFO - 'default_actions': ('clobber', 16:05:40 INFO - 'read-buildbot-config', 16:05:40 INFO - 'download-and-extract', 16:05:40 INFO - 'populate-webroot', 16:05:40 INFO - 'create-virtualenv', 16:05:40 INFO - 'install', 16:05:40 INFO - 'run-tests'), 16:05:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:05:40 INFO - 'download_minidump_stackwalk': True, 16:05:40 INFO - 'download_symbols': 'ondemand', 16:05:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:05:40 INFO - 'tooltool.py': '/tools/tooltool.py', 16:05:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:05:40 INFO - '/tools/misc-python/virtualenv.py')}, 16:05:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:05:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:05:40 INFO - 'installer_path': 'installer.exe', 16:05:40 INFO - 'log_level': 'info', 16:05:40 INFO - 'log_name': 'talos', 16:05:40 INFO - 'log_to_console': True, 16:05:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:05:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:05:40 INFO - 'opt_config_files': (), 16:05:40 INFO - 'pip_index': False, 16:05:40 INFO - 'sps_profile': False, 16:05:40 INFO - 'sps_profile_interval': 0, 16:05:40 INFO - 'suite': 'dromaeojs', 16:05:40 INFO - 'system_bits': '32', 16:05:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:05:40 INFO - 'title': 'talos-linux64-ix-042', 16:05:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:05:40 INFO - 'use_talos_json': True, 16:05:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:05:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:05:40 INFO - 'work_dir': 'build'} 16:05:40 INFO - [mozharness: 2016-10-30 23:05:40.346834Z] Running clobber step. 16:05:40 INFO - Running pre-action listener: _resource_record_pre_action 16:05:40 INFO - Running main action method: clobber 16:05:40 INFO - rmtree: /builds/slave/test/build 16:05:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:05:40 INFO - Running post-action listener: _resource_record_post_action 16:05:40 INFO - [mozharness: 2016-10-30 23:05:40.819910Z] Finished clobber step (success) 16:05:40 INFO - [mozharness: 2016-10-30 23:05:40.820012Z] Running read-buildbot-config step. 16:05:40 INFO - Running pre-action listener: _resource_record_pre_action 16:05:40 INFO - Running main action method: read_buildbot_config 16:05:40 INFO - Using buildbot properties: 16:05:40 INFO - { 16:05:40 INFO - "project": "", 16:05:40 INFO - "product": "firefox", 16:05:40 INFO - "script_repo_revision": "production", 16:05:40 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:05:40 INFO - "repository": "", 16:05:40 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 16:05:40 INFO - "buildid": "20161030123004", 16:05:40 INFO - "pgo_build": "True", 16:05:40 INFO - "basedir": "/builds/slave/test", 16:05:40 INFO - "buildnumber": 575, 16:05:40 INFO - "slavename": "talos-linux64-ix-042", 16:05:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:05:40 INFO - "platform": "ubuntu64_hw", 16:05:40 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 16:05:40 INFO - "branch": "fx-team", 16:05:40 INFO - "repo_path": "integration/fx-team", 16:05:40 INFO - "revision": "e3279760cd977aac30bd9e8032d3ee71f55d2a67", 16:05:40 INFO - "stage_platform": "linux64-pgo", 16:05:40 INFO - "builduid": "fde67ece1338478497d193b84281b7f8", 16:05:40 INFO - "slavebuilddir": "test" 16:05:40 INFO - } 16:05:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:05:40 INFO - Running post-action listener: _resource_record_post_action 16:05:40 INFO - [mozharness: 2016-10-30 23:05:40.822489Z] Finished read-buildbot-config step (success) 16:05:40 INFO - [mozharness: 2016-10-30 23:05:40.822591Z] Running download-and-extract step. 16:05:40 INFO - Running pre-action listener: _resource_record_pre_action 16:05:40 INFO - Running main action method: download_and_extract 16:05:40 INFO - mkdir: /builds/slave/test/build/tests 16:05:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:05:40 INFO - trying https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:05:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/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 16:05:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/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 16:05:41 INFO - Downloaded 1361 bytes. 16:05:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:05:41 INFO - Using the following test package requirements: 16:05:41 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:41 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:05:41 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:05:41 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'jsshell-linux-x86_64.zip'], 16:05:41 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:05:41 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:05:41 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:05:41 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:05:41 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:05:41 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:05:41 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:05:41 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:05:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:05:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:05:41 INFO - Fetch https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:05:42 INFO - Http code: 200 16:05:42 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 16:05:42 INFO - x-amz-cf-id: n_cB6AKYHkmOTQ1a4zz0_KDq3x5jQwusf755b38yDDBtIAozLBACfw== 16:05:42 INFO - x-amz-version-id: ox1ZhLsAGIofrXIPUXOYGBg332c4Whb7 16:05:42 INFO - Expected file size: 22006771 16:05:42 INFO - Obtained file size: 22006771 16:05:46 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 16:05:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:05:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:05:46 INFO - Fetch https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:05:46 INFO - Http code: 200 16:05:46 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 16:05:46 INFO - x-amz-cf-id: UALl2VPrSa7rhUwlJHgRChuWrQxyPJJX3Xsi76ieT8bIVYpuAGALIg== 16:05:46 INFO - x-amz-version-id: ox1ZhLsAGIofrXIPUXOYGBg332c4Whb7 16:05:47 INFO - Expected file size: 22006771 16:05:47 INFO - Obtained file size: 22006771 16:05:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:05:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:05:51 INFO - Fetch https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:05:52 INFO - Http code: 200 16:05:52 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 16:05:52 INFO - x-amz-cf-id: 8nSR3aJGBg3oD8PMlPulSyJgeHDAp-VS7DIobpyR1X_SyTALHzyh5A== 16:05:52 INFO - x-amz-version-id: I3Z_Jxp0kSGtKUgAjUfytgDFlLMOYIKL 16:05:52 INFO - Expected file size: 14409038 16:05:52 INFO - Obtained file size: 14409038 16:05:52 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')]} 16:05:52 INFO - trying https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:05:52 INFO - Downloading https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/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 16:05:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/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 16:05:53 INFO - Downloaded 59632897 bytes. 16:05:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:05:53 INFO - mkdir: /builds/slave/test/properties 16:05:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:05:53 INFO - Writing to file /builds/slave/test/properties/build_url 16:05:53 INFO - Contents: 16:05:53 INFO - build_url:https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:05:54 INFO - Running post-action listener: _resource_record_post_action 16:05:54 INFO - Running post-action listener: set_extra_try_arguments 16:05:54 INFO - [mozharness: 2016-10-30 23:05:54.645948Z] Finished download-and-extract step (success) 16:05:54 INFO - [mozharness: 2016-10-30 23:05:54.646175Z] Running populate-webroot step. 16:05:54 INFO - Running pre-action listener: _resource_record_pre_action 16:05:54 INFO - Running main action method: populate_webroot 16:05:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:05:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:05:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:05:54 INFO - '--tppagecycles', 16:05:54 INFO - '7'], 16:05:54 INFO - 'tests': ['tsvgm']}}, 16:05:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:05:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:05:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:05:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:05:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:05:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['damp', 'tps']}, 16:05:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'tests': ['damp', 'tps']}, 16:05:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['dromaeo_dom']}, 16:05:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:05:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['basic_compositor_video']}, 16:05:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:05:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'other-e10s': {'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['a11yr', 16:05:54 INFO - 'ts_paint', 16:05:54 INFO - 'tpaint', 16:05:54 INFO - 'sessionrestore', 16:05:54 INFO - 'sessionrestore_no_auto_restore', 16:05:54 INFO - 'tabpaint']}, 16:05:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['tsvgx', 16:05:54 INFO - 'tsvgr_opacity', 16:05:54 INFO - 'tart', 16:05:54 INFO - 'tscrollx', 16:05:54 INFO - 'cart']}, 16:05:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:05:54 INFO - 'tsvgr_opacity', 16:05:54 INFO - 'tart', 16:05:54 INFO - 'tscrollx', 16:05:54 INFO - 'cart']}, 16:05:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'talos_options': ['--disable-e10s'], 16:05:54 INFO - 'tests': ['tp5o']}, 16:05:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'tests': ['tp5o']}, 16:05:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'talos_options': ['--disable-e10s', 16:05:54 INFO - '--xperf_path', 16:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:54 INFO - 'tests': ['tp5n']}, 16:05:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:05:54 INFO - 'talos_options': ['--xperf_path', 16:05:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:05:54 INFO - 'tests': ['tp5n']}}, 16:05:54 INFO - 'talos.zip': {'path': '', 16:05:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:05:54 INFO - Running post-action listener: _resource_record_post_action 16:05:54 INFO - [mozharness: 2016-10-30 23:05:54.667157Z] Finished populate-webroot step (success) 16:05:54 INFO - [mozharness: 2016-10-30 23:05:54.667246Z] Running create-virtualenv step. 16:05:54 INFO - Running pre-action listener: _resource_record_pre_action 16:05:54 INFO - Running main action method: create_virtualenv 16:05:54 INFO - Creating virtualenv /builds/slave/test/build/venv 16:05:54 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 16:05:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:05:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:05:54 INFO - Using real prefix '/usr' 16:05:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:05:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:05:57 INFO - Installing pip.................done. 16:05:57 INFO - Return code: 0 16:05:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:05:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:05:57 INFO - Reading from file tmpfile_stdout 16:05:57 INFO - Output received: 16:05:57 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) 16:05:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:05:57 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')]} 16:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:57 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')]} 16:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:57 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:05:57 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 16:05:57 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 16:05:57 INFO - Using env: {'DISPLAY': ':0', 16:05:57 INFO - 'HOME': '/home/cltbld', 16:05:57 INFO - 'LANG': 'en_US.UTF-8', 16:05:57 INFO - 'LANGUAGE': 'en_US:en', 16:05:57 INFO - 'LOGNAME': 'cltbld', 16:05:57 INFO - 'MAIL': '/var/mail/cltbld', 16:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:57 INFO - 'MOZ_NO_REMOTE': '1', 16:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:57 INFO - 'NO_EM_RESTART': '1', 16:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:57 INFO - 'PWD': '/builds/slave/test', 16:05:57 INFO - 'SHELL': '/bin/bash', 16:05:57 INFO - 'SHLVL': '1', 16:05:57 INFO - 'TERM': 'linux', 16:05:57 INFO - 'TMOUT': '86400', 16:05:57 INFO - 'USER': 'cltbld', 16:05:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:57 INFO - '_': '/tools/buildbot/bin/python'} 16:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:57 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 16:05:57 INFO - Cleaning up... 16:05:57 INFO - Return code: 0 16:05:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:05:57 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')]} 16:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:57 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')]} 16:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:05:57 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:05:57 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 16:05:57 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 16:05:57 INFO - Using env: {'DISPLAY': ':0', 16:05:57 INFO - 'HOME': '/home/cltbld', 16:05:57 INFO - 'LANG': 'en_US.UTF-8', 16:05:57 INFO - 'LANGUAGE': 'en_US:en', 16:05:57 INFO - 'LOGNAME': 'cltbld', 16:05:57 INFO - 'MAIL': '/var/mail/cltbld', 16:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:05:57 INFO - 'MOZ_NO_REMOTE': '1', 16:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:05:57 INFO - 'NO_EM_RESTART': '1', 16:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:05:57 INFO - 'PWD': '/builds/slave/test', 16:05:57 INFO - 'SHELL': '/bin/bash', 16:05:57 INFO - 'SHLVL': '1', 16:05:57 INFO - 'TERM': 'linux', 16:05:57 INFO - 'TMOUT': '86400', 16:05:57 INFO - 'USER': 'cltbld', 16:05:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:05:57 INFO - '_': '/tools/buildbot/bin/python'} 16:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:05:57 INFO - Downloading/unpacking psutil>=3.1.1 16:05:57 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 16:05:57 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 16:05:57 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 16:05:57 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 16:05:57 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 16:05:57 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 16:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:05:59 INFO - Installing collected packages: psutil 16:05:59 INFO - Running setup.py install for psutil 16:06:00 INFO - building 'psutil._psutil_linux' extension 16:06:00 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 16:06:00 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 16:06:00 INFO - building 'psutil._psutil_posix' extension 16:06:00 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 16:06:00 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 16:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:06:00 INFO - Successfully installed psutil 16:06:00 INFO - Cleaning up... 16:06:00 INFO - Return code: 0 16:06:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:06:00 INFO - Using env: {'DISPLAY': ':0', 16:06:00 INFO - 'HOME': '/home/cltbld', 16:06:00 INFO - 'LANG': 'en_US.UTF-8', 16:06:00 INFO - 'LANGUAGE': 'en_US:en', 16:06:00 INFO - 'LOGNAME': 'cltbld', 16:06:00 INFO - 'MAIL': '/var/mail/cltbld', 16:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:00 INFO - 'MOZ_NO_REMOTE': '1', 16:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:00 INFO - 'NO_EM_RESTART': '1', 16:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:00 INFO - 'PWD': '/builds/slave/test', 16:06:00 INFO - 'SHELL': '/bin/bash', 16:06:00 INFO - 'SHLVL': '1', 16:06:00 INFO - 'TERM': 'linux', 16:06:00 INFO - 'TMOUT': '86400', 16:06:00 INFO - 'USER': 'cltbld', 16:06:00 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:00 INFO - '_': '/tools/buildbot/bin/python'} 16:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:06:00 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 16:06:00 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 16:06:00 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 16:06:00 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 16:06:00 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 16:06:00 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 16:06:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:06:02 INFO - Installing collected packages: mozsystemmonitor 16:06:02 INFO - Running setup.py install for mozsystemmonitor 16:06:02 INFO - Successfully installed mozsystemmonitor 16:06:02 INFO - Cleaning up... 16:06:02 INFO - Return code: 0 16:06:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:06:02 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')]} 16:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:02 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')]} 16:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:02 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:02 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 16:06:02 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 16:06:02 INFO - Using env: {'DISPLAY': ':0', 16:06:02 INFO - 'HOME': '/home/cltbld', 16:06:02 INFO - 'LANG': 'en_US.UTF-8', 16:06:02 INFO - 'LANGUAGE': 'en_US:en', 16:06:02 INFO - 'LOGNAME': 'cltbld', 16:06:02 INFO - 'MAIL': '/var/mail/cltbld', 16:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:02 INFO - 'MOZ_NO_REMOTE': '1', 16:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:02 INFO - 'NO_EM_RESTART': '1', 16:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:02 INFO - 'PWD': '/builds/slave/test', 16:06:02 INFO - 'SHELL': '/bin/bash', 16:06:02 INFO - 'SHLVL': '1', 16:06:02 INFO - 'TERM': 'linux', 16:06:02 INFO - 'TMOUT': '86400', 16:06:02 INFO - 'USER': 'cltbld', 16:06:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:02 INFO - '_': '/tools/buildbot/bin/python'} 16:06:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:03 INFO - Downloading/unpacking jsonschema==2.5.1 16:06:03 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 16:06:03 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 16:06:03 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 16:06:03 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 16:06:03 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 16:06:03 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 16:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:06:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:06:05 INFO - warning: no files found matching '*.txt' 16:06:05 INFO - no previously-included directories found matching 'build' 16:06:05 INFO - no previously-included directories found matching 'dist' 16:06:05 INFO - no previously-included directories found matching '.git*' 16:06:05 INFO - Installing collected packages: jsonschema, functools32 16:06:05 INFO - Running setup.py install for functools32 16:06:05 INFO - warning: no files found matching '*.txt' 16:06:05 INFO - no previously-included directories found matching 'build' 16:06:05 INFO - no previously-included directories found matching 'dist' 16:06:05 INFO - no previously-included directories found matching '.git*' 16:06:05 INFO - Successfully installed jsonschema functools32 16:06:05 INFO - Cleaning up... 16:06:05 INFO - Return code: 0 16:06:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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', '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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:06: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 functools32==3.2.3-2 16:06:05 INFO - Using env: {'DISPLAY': ':0', 16:06:05 INFO - 'HOME': '/home/cltbld', 16:06:05 INFO - 'LANG': 'en_US.UTF-8', 16:06:05 INFO - 'LANGUAGE': 'en_US:en', 16:06:05 INFO - 'LOGNAME': 'cltbld', 16:06:05 INFO - 'MAIL': '/var/mail/cltbld', 16:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:05 INFO - 'MOZ_NO_REMOTE': '1', 16:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:05 INFO - 'NO_EM_RESTART': '1', 16:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:05 INFO - 'PWD': '/builds/slave/test', 16:06:05 INFO - 'SHELL': '/bin/bash', 16:06:05 INFO - 'SHLVL': '1', 16:06:05 INFO - 'TERM': 'linux', 16:06:05 INFO - 'TMOUT': '86400', 16:06:05 INFO - 'USER': 'cltbld', 16:06:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:05 INFO - '_': '/tools/buildbot/bin/python'} 16:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:06:05 INFO - Cleaning up... 16:06:05 INFO - Return code: 0 16:06:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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', '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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:06: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 blobuploader==1.2.4 16:06:05 INFO - Using env: {'DISPLAY': ':0', 16:06:05 INFO - 'HOME': '/home/cltbld', 16:06:05 INFO - 'LANG': 'en_US.UTF-8', 16:06:05 INFO - 'LANGUAGE': 'en_US:en', 16:06:05 INFO - 'LOGNAME': 'cltbld', 16:06:05 INFO - 'MAIL': '/var/mail/cltbld', 16:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:05 INFO - 'MOZ_NO_REMOTE': '1', 16:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:05 INFO - 'NO_EM_RESTART': '1', 16:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:05 INFO - 'PWD': '/builds/slave/test', 16:06:05 INFO - 'SHELL': '/bin/bash', 16:06:05 INFO - 'SHLVL': '1', 16:06:05 INFO - 'TERM': 'linux', 16:06:05 INFO - 'TMOUT': '86400', 16:06:05 INFO - 'USER': 'cltbld', 16:06:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:05 INFO - '_': '/tools/buildbot/bin/python'} 16:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 16:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:06:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:06:07 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 16:06:07 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 16:06:07 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 16:06:07 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 16:06:07 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 16:06:07 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 16:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:06:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:08 INFO - Downloading docopt-0.6.1.tar.gz 16:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:06:08 INFO - Installing collected packages: blobuploader, requests, docopt 16:06:08 INFO - Running setup.py install for blobuploader 16:06:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:06:08 INFO - Running setup.py install for requests 16:06:09 INFO - Running setup.py install for docopt 16:06:09 INFO - Successfully installed blobuploader requests docopt 16:06:09 INFO - Cleaning up... 16:06:09 INFO - Return code: 0 16:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:09 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:09 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 16:06:09 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 16:06:09 INFO - Using env: {'DISPLAY': ':0', 16:06:09 INFO - 'HOME': '/home/cltbld', 16:06:09 INFO - 'LANG': 'en_US.UTF-8', 16:06:09 INFO - 'LANGUAGE': 'en_US:en', 16:06:09 INFO - 'LOGNAME': 'cltbld', 16:06:09 INFO - 'MAIL': '/var/mail/cltbld', 16:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:09 INFO - 'MOZ_NO_REMOTE': '1', 16:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:09 INFO - 'NO_EM_RESTART': '1', 16:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:09 INFO - 'PWD': '/builds/slave/test', 16:06:09 INFO - 'SHELL': '/bin/bash', 16:06:09 INFO - 'SHLVL': '1', 16:06:09 INFO - 'TERM': 'linux', 16:06:09 INFO - 'TMOUT': '86400', 16:06:09 INFO - 'USER': 'cltbld', 16:06:09 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:09 INFO - '_': '/tools/buildbot/bin/python'} 16:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:09 INFO - Running setup.py (path:/tmp/pip-vQY60b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:09 INFO - Running setup.py (path:/tmp/pip-7CrHG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:09 INFO - Running setup.py (path:/tmp/pip-ozRXER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:09 INFO - Running setup.py (path:/tmp/pip-UEsy3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:09 INFO - Running setup.py (path:/tmp/pip-uD3fuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:09 INFO - Running setup.py (path:/tmp/pip-EqgAHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:09 INFO - Running setup.py (path:/tmp/pip-pDUS6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:09 INFO - Running setup.py (path:/tmp/pip-Zkz22r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:10 INFO - Running setup.py (path:/tmp/pip-6yM_qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:10 INFO - Running setup.py (path:/tmp/pip-Umt2tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:10 INFO - Running setup.py (path:/tmp/pip-sHkbdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:10 INFO - Running setup.py (path:/tmp/pip-U0DUxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:10 INFO - Running setup.py (path:/tmp/pip-4lF9Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:10 INFO - Running setup.py (path:/tmp/pip-pKYLKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:10 INFO - Running setup.py (path:/tmp/pip-nilQcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:10 INFO - Running setup.py (path:/tmp/pip-YEGb3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:10 INFO - Running setup.py (path:/tmp/pip-V4IdGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:06:10 INFO - Running setup.py install for manifestparser 16:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:06:10 INFO - Running setup.py install for mozcrash 16:06:10 INFO - Running setup.py install for mozdebug 16:06:10 INFO - Running setup.py install for mozdevice 16:06:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for mozfile 16:06:11 INFO - Running setup.py install for mozhttpd 16:06:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for mozinfo 16:06:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for mozInstall 16:06:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for mozleak 16:06:11 INFO - Running setup.py install for mozlog 16:06:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for moznetwork 16:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:06:11 INFO - Running setup.py install for mozprocess 16:06:11 INFO - Running setup.py install for mozprofile 16:06:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:06:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:06:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:06:12 INFO - Running setup.py install for mozrunner 16:06:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:06:12 INFO - Running setup.py install for mozscreenshot 16:06:12 INFO - Running setup.py install for moztest 16:06:12 INFO - Running setup.py install for mozversion 16:06:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:06:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:06:12 INFO - Cleaning up... 16:06:12 INFO - Return code: 0 16:06:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06:12 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')]} 16:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:12 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')]} 16:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:12 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:12 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 16:06:12 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 16:06:12 INFO - Using env: {'DISPLAY': ':0', 16:06:12 INFO - 'HOME': '/home/cltbld', 16:06:12 INFO - 'LANG': 'en_US.UTF-8', 16:06:12 INFO - 'LANGUAGE': 'en_US:en', 16:06:12 INFO - 'LOGNAME': 'cltbld', 16:06:12 INFO - 'MAIL': '/var/mail/cltbld', 16:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:12 INFO - 'MOZ_NO_REMOTE': '1', 16:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:12 INFO - 'NO_EM_RESTART': '1', 16:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:12 INFO - 'PWD': '/builds/slave/test', 16:06:12 INFO - 'SHELL': '/bin/bash', 16:06:12 INFO - 'SHLVL': '1', 16:06:12 INFO - 'TERM': 'linux', 16:06:12 INFO - 'TMOUT': '86400', 16:06:12 INFO - 'USER': 'cltbld', 16:06:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:12 INFO - '_': '/tools/buildbot/bin/python'} 16:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:06:12 INFO - Running setup.py (path:/tmp/pip-o9YAci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:06:12 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)) 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:06:12 INFO - Running setup.py (path:/tmp/pip-QGR34H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:06:12 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)) 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:06:12 INFO - Running setup.py (path:/tmp/pip-KAxOT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:06:12 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)) 16:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:06:12 INFO - Running setup.py (path:/tmp/pip-yiMQiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:06:13 INFO - Running setup.py (path:/tmp/pip-oJ7R8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:06:13 INFO - Running setup.py (path:/tmp/pip-fVkn36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:06:13 INFO - Running setup.py (path:/tmp/pip-dui_oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:06:13 INFO - Running setup.py (path:/tmp/pip-vyzK4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:06:13 INFO - Running setup.py (path:/tmp/pip-kNJrbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:06:13 INFO - Running setup.py (path:/tmp/pip-JXRb3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:06:13 INFO - Running setup.py (path:/tmp/pip-sF_Qu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:06:13 INFO - Running setup.py (path:/tmp/pip-W4mrDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:06:13 INFO - Running setup.py (path:/tmp/pip-wf_kxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:06:13 INFO - Running setup.py (path:/tmp/pip-SbL0nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:13 INFO - Running setup.py (path:/tmp/pip-8VsOuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:06:13 INFO - Running setup.py (path:/tmp/pip-3GgLp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:06:13 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)) 16:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:06:13 INFO - Running setup.py (path:/tmp/pip-tc5BJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:06:13 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)) 16:06:13 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)) 16:06:13 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)) 16:06:13 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)) 16:06:13 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)) 16:06:13 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)) 16:06:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06: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 16:06:15 INFO - Downloading blessings-1.6.tar.gz 16:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:06:15 INFO - Installing collected packages: blessings 16:06:15 INFO - Running setup.py install for blessings 16:06:16 INFO - Successfully installed blessings 16:06:16 INFO - Cleaning up... 16:06:16 INFO - Return code: 0 16:06:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:16 INFO - Reading from file tmpfile_stdout 16:06:16 INFO - Current package versions: 16:06:16 INFO - argparse == 1.2.1 16:06:16 INFO - blessings == 1.6 16:06:16 INFO - blobuploader == 1.2.4 16:06:16 INFO - docopt == 0.6.1 16:06:16 INFO - functools32 == 3.2.3-2 16:06:16 INFO - jsonschema == 2.5.1 16:06:16 INFO - manifestparser == 1.1 16:06:16 INFO - mozInstall == 1.12 16:06:16 INFO - mozcrash == 0.17 16:06:16 INFO - mozdebug == 0.1 16:06:16 INFO - mozdevice == 0.48 16:06:16 INFO - mozfile == 1.2 16:06:16 INFO - mozhttpd == 0.7 16:06:16 INFO - mozinfo == 0.9 16:06:16 INFO - mozleak == 0.1 16:06:16 INFO - mozlog == 3.4 16:06:16 INFO - moznetwork == 0.27 16:06:16 INFO - mozprocess == 0.23 16:06:16 INFO - mozprofile == 0.28 16:06:16 INFO - mozrunner == 6.12 16:06:16 INFO - mozscreenshot == 0.1 16:06:16 INFO - mozsystemmonitor == 0.3 16:06:16 INFO - moztest == 0.7 16:06:16 INFO - mozversion == 1.4 16:06:16 INFO - psutil == 3.1.1 16:06:16 INFO - requests == 1.2.3 16:06:16 INFO - wsgiref == 0.1.2 16:06:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:16 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:16 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 16:06:16 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 16:06:16 INFO - Using env: {'DISPLAY': ':0', 16:06:16 INFO - 'HOME': '/home/cltbld', 16:06:16 INFO - 'LANG': 'en_US.UTF-8', 16:06:16 INFO - 'LANGUAGE': 'en_US:en', 16:06:16 INFO - 'LOGNAME': 'cltbld', 16:06:16 INFO - 'MAIL': '/var/mail/cltbld', 16:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:16 INFO - 'MOZ_NO_REMOTE': '1', 16:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:16 INFO - 'NO_EM_RESTART': '1', 16:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:16 INFO - 'PWD': '/builds/slave/test', 16:06:16 INFO - 'SHELL': '/bin/bash', 16:06:16 INFO - 'SHLVL': '1', 16:06:16 INFO - 'TERM': 'linux', 16:06:16 INFO - 'TMOUT': '86400', 16:06:16 INFO - 'USER': 'cltbld', 16:06:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:16 INFO - '_': '/tools/buildbot/bin/python'} 16:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 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)) 16:06:16 INFO - Cleaning up... 16:06:16 INFO - Return code: 0 16:06:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:06: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')]} 16:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:06:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06: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')]} 16:06:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:06:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:06:16 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 0x7f5e40f5ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x184a790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', '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 16:06:16 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 16:06:16 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 16:06:16 INFO - Using env: {'DISPLAY': ':0', 16:06:16 INFO - 'HOME': '/home/cltbld', 16:06:16 INFO - 'LANG': 'en_US.UTF-8', 16:06:16 INFO - 'LANGUAGE': 'en_US:en', 16:06:16 INFO - 'LOGNAME': 'cltbld', 16:06:16 INFO - 'MAIL': '/var/mail/cltbld', 16:06:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:16 INFO - 'MOZ_NO_REMOTE': '1', 16:06:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:16 INFO - 'NO_EM_RESTART': '1', 16:06:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:16 INFO - 'PWD': '/builds/slave/test', 16:06:16 INFO - 'SHELL': '/bin/bash', 16:06:16 INFO - 'SHLVL': '1', 16:06:16 INFO - 'TERM': 'linux', 16:06:16 INFO - 'TMOUT': '86400', 16:06:16 INFO - 'USER': 'cltbld', 16:06:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:16 INFO - '_': '/tools/buildbot/bin/python'} 16:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:06:16 INFO - Cleaning up... 16:06:16 INFO - Return code: 0 16:06:16 INFO - Running post-action listener: _resource_record_post_action 16:06:16 INFO - Running post-action listener: _start_resource_monitoring 16:06:16 INFO - Starting resource monitoring. 16:06:16 INFO - [mozharness: 2016-10-30 23:06:16.850725Z] Finished create-virtualenv step (success) 16:06:16 INFO - [mozharness: 2016-10-30 23:06:16.851245Z] Running install step. 16:06:16 INFO - Running pre-action listener: _resource_record_pre_action 16:06:16 INFO - Running main action method: install 16:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:06:17 INFO - Reading from file tmpfile_stdout 16:06:17 INFO - Detecting whether we're running mozinstall >=1.0... 16:06:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:06:17 INFO - Reading from file tmpfile_stdout 16:06:17 INFO - Output received: 16:06:17 INFO - Usage: mozinstall [options] installer 16:06:17 INFO - Options: 16:06:17 INFO - -h, --help show this help message and exit 16:06:17 INFO - -d DEST, --destination=DEST 16:06:17 INFO - Directory to install application into. [default: 16:06:17 INFO - "/builds/slave/test"] 16:06:17 INFO - --app=APP Application being installed. [default: firefox] 16:06:17 INFO - mkdir: /builds/slave/test/build/application 16:06:17 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'] 16:06:17 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 16:06:34 INFO - Reading from file tmpfile_stdout 16:06:34 INFO - Output received: 16:06:34 INFO - /builds/slave/test/build/application/firefox/firefox 16:06:34 INFO - Running post-action listener: _resource_record_post_action 16:06:34 INFO - [mozharness: 2016-10-30 23:06:34.607671Z] Finished install step (success) 16:06:34 INFO - [mozharness: 2016-10-30 23:06:34.607914Z] Running run-tests step. 16:06:34 INFO - Running pre-action listener: _resource_record_pre_action 16:06:34 INFO - Running main action method: run_tests 16:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:06:34 INFO - Python 2.7.3 16:06:34 INFO - Return code: 0 16:06:34 INFO - grabbing minidump binary from tooltool 16:06:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:06:34 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 0x1847930>, '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 0x1848830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1848cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:06:34 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 16:06:34 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 16:06:34 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 16:06:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:06:34 INFO - Return code: 0 16:06:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:06:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:06:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:06:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:06:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 16:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 16:06:34 INFO - Using env: {'DISPLAY': ':0', 16:06:34 INFO - 'HOME': '/home/cltbld', 16:06:34 INFO - 'LANG': 'en_US.UTF-8', 16:06:34 INFO - 'LANGUAGE': 'en_US:en', 16:06:34 INFO - 'LOGNAME': 'cltbld', 16:06:34 INFO - 'MAIL': '/var/mail/cltbld', 16:06:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:06:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:06:34 INFO - 'MOZ_NO_REMOTE': '1', 16:06:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:06:34 INFO - 'NO_EM_RESTART': '1', 16:06:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:06:34 INFO - 'PWD': '/builds/slave/test', 16:06:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:06:34 INFO - 'SHELL': '/bin/bash', 16:06:34 INFO - 'SHLVL': '1', 16:06:34 INFO - 'TERM': 'linux', 16:06:34 INFO - 'TMOUT': '86400', 16:06:34 INFO - 'USER': 'cltbld', 16:06:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590', 16:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:06:34 INFO - '_': '/tools/buildbot/bin/python'} 16:06:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 16:06:34 INFO - mozversion application_buildid: 20161030123004 16:06:34 INFO - mozversion application_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 16:06:34 INFO - mozversion application_display_name: Nightly 16:06:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:06:34 INFO - mozversion application_name: Firefox 16:06:34 INFO - mozversion application_remotingname: firefox 16:06:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:06:34 INFO - mozversion application_vendor: Mozilla 16:06:34 INFO - mozversion application_version: 52.0a1 16:06:34 INFO - mozversion platform_buildid: 20161030123004 16:06:34 INFO - mozversion platform_changeset: e3279760cd977aac30bd9e8032d3ee71f55d2a67 16:06:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:06:34 INFO - mozversion platform_version: 52.0a1 16:06:34 INFO - using testdate: 1477868794 16:06:34 INFO - actual date: 1477868794 16:06:34 INFO - starting webserver on 'localhost:58756' 16:06:34 INFO - SUITE-START | Running 2 tests 16:06:34 INFO - TEST-START | dromaeo_css 16:06:34 INFO - operating with platform_type : linux_ 16:06:34 INFO - Initialising browser for dromaeo_css test... 16:06:34 INFO - TEST-INFO | started process 9731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb9VM7u/profile http://localhost:58756/getInfo.html) 16:06:38 INFO - PROCESS | 9731 | __metrics Screen width/height:1600/1200 16:06:38 INFO - PROCESS | 9731 | colorDepth:24 16:06:38 INFO - PROCESS | 9731 | Browser inner width/height: 1024/697 16:06:38 INFO - PROCESS | 9731 | __metrics 16:06:39 INFO - PROCESS | 9731 | 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" 16:06:39 INFO - PROCESS | 9731 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:06:40 INFO - PROCESS | 9731 | console.error: PushService: 16:06:40 INFO - PROCESS | 9731 | stateChangeProcessEnqueue: Error transitioning state 16:06:40 INFO - PROCESS | 9731 | UnknownError 16:06:40 INFO - TEST-INFO | 9731: exit 0 16:06:40 INFO - Browser initialized. 16:06:40 INFO - Running cycle 1/1 for dromaeo_css test... 16:06:40 INFO - TEST-INFO | started process 9817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb9VM7u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:53 INFO - PROCESS | 9817 | RSS: Main: 174100480 16:06:53 INFO - PROCESS | 9817 | 16:07:44 INFO - PROCESS | 9817 | 1477868864319 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] 16:09:55 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58756/tests/dromaeo/cssquery-ext.html) 16:09:57 INFO - PROCESS | 9817 | RSS: Main: 361115648 16:09:57 INFO - PROCESS | 9817 | 16:12:59 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-ext.html (next: http://localhost:58756/tests/dromaeo/cssquery-jquery.html) 16:13:00 INFO - PROCESS | 9817 | RSS: Main: 278888448 16:13:00 INFO - PROCESS | 9817 | 16:16:02 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58756/tests/dromaeo/cssquery-mootools.html) 16:16:03 INFO - PROCESS | 9817 | RSS: Main: 216039424 16:16:03 INFO - PROCESS | 9817 | 16:19:05 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58756/tests/dromaeo/cssquery-prototype.html) 16:19:05 INFO - PROCESS | 9817 | RSS: Main: 255852544 16:19:05 INFO - PROCESS | 9817 | 16:22:08 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58756/tests/dromaeo/cssquery-yui.html) 16:22:09 INFO - PROCESS | 9817 | RSS: Main: 219783168 16:22:09 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | Cycle 1(1): loaded http://localhost:58756/tests/dromaeo/cssquery-yui.html (next: http://localhost:58756/tests/dromaeo/cssquery-dojo.html) 16:25:11 INFO - PROCESS | 9817 | RSS: Main: 313487360 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | __start_tp_report 16:25:11 INFO - PROCESS | 9817 | _x_x_mozilla_page_load 16:25:11 INFO - PROCESS | 9817 | _x_x_mozilla_page_load_details 16:25:11 INFO - PROCESS | 9817 | |i|pagename|runs| 16:25:11 INFO - PROCESS | 9817 | |0;dojo.html;3047.7257046865784;3082.0599717086307;3108.797928134671;3123.1411361875494;3128.374325134974;5279.947200527993;5362.570994320455;5376.327959005124;5436.700981446019;5468.972655136724;5412.891742165154;5420.810271640484;5423.430539793324;5432.348118225808;5450.155225939976;4870.610351171907;4889.682170658896;4905.190643543811;4940.1601727706375;4967.627427942901;4952.257161425779;5011.899762004758;5013.172826483644;5013.774380152902;5016.924746128811;4908.239222920453;4946.183879659852;4963.851084467472;4979.1784355581285;5013.473585273548;5005.724685142316;5028;5034.11902916988;5037.5214354636255;5092.236164575306;4787.80848766049;4827.372441582572;4860.343853579757;4921.655484116113;4931.457539670633;5395.05586522357;5407.297051383295;5419.403865574784;5437.293151890229;5501.807436739735;5826.737796799154;5856.590038697293;5861.794837180678;5864.1203819427;5869.06095024794;5634.577406694473;5772.3361813391575;5788.450097240755;5905.350411454737;5914.349421563625;5377.677339359651;5416.702081385482;5417.485338892799;5476.151196564579;5482.985647655197;5939.495142912814;5992.610480318765;5992.910106348409;5996.550258730613;5997.100434934795;5396.406395296514;5471.2887324647545;5730.656160630376;5734.455226753452;5743.282089738783;5608.859778505488;5648.096304591246;5654.208410822488;5701;5752.165935939349;5676.176954341598;5685.289338832646;5729.312482502127;5740;5741.540676745851;5605.383407825136;5786.913196302059;5787.739551720183;5788.479036886701;5841.853953651193;4350.956490435118;4356.891077723082;4370.737755734666;4407.669424793154;4409.625181859514;3938.074552480165;3939.0940083780893;3943.369060950234;3984.541777695602;3985.3025720498795;5498.5876059295715;5503.807366742145;5517.227588137664;5519.917201241985;5582.609217354746;5580.1629755537;5620.1288800236025;5698.515626171822;5739.454751798572;5851.356350801409;5440.075187218183;5469.945300547023;5487.149491828773;5498;5500.532454741392;4949.406071271471;4982.227754698028;4987.975060124749;4988.551030407209;5036.345275114211;5770.538356931519;5838.591298609056;5887;5888.822235552907;5905.704714764331;5627.324721033502;5727.083666613322;5751.971240143773;5762.135679648086;5867.618604790675;5960;5968.373320801254;5976.8804623908145;5981.491573216325;5984.31180414258;5672.12082127271;5685.857853553529;5695.345035320991;5695.629784064023;5695.803881184997;5559.388467268516;5676.68778217202;5777.508911742549;5806.332271788799;5824.883502329845;5674.886502270014;5708.80019199326;5715.799947002001;5731.426857314235;5760.222369980167;5707.172459993195;5711.685857277889;5714.657120572779;5714.828555143353;5717.799877004285;5426.375966763872;5485.533729633026;5501.229827824188;5609.831705048855;5690;5657;5661;5663.490285874291;5665.745041473061;5667.801626943037;5509.090999984957;5522.944770552243;5546.556275498031;5552.500274975271;5557.249771280825 16:25:11 INFO - PROCESS | 9817 | |1;ext.html;543.2472703290262;592.2803793391031;617.367198621413;630.7792272704551;641.8459569703273;31493.527597086035;41122.38316425256;41991.160176796446;41994.58005419945;42004.78997605015;44189.139194688556;44547;44565.55434445655;44665.330020049725;44686.553134468646;7839.843203135933;8793.252573531257;8967.103289671046;8970.071434641552;8976.46141231525;8022.3582113431075;8050.4364694471415;8051.51690898548;10399.428031458267;10655.946720266427;10774.515146818412;10797.028267455928;10839;10842.295250808711;10849.728756781065;10615.203859710553;10617.893821061845;10640.148788096934;10646.148308135369;10657.52041158142;10638.893611063868;10692.679219623424;10707.411092389915;10713.517891694892;10722.0886224671;40974.180516389504;41413.37879931804;41510.79244603758;41689.58310416887;41733.791331043154;3270.934581308384;3281.9015429537153;3310.470324748029;3494.318607871466;3545.308664810363;30789.15265084102;31142;31167.37665246705;31972.840135799404;32189.83905080483;3995.9200815983518;4057.107436363995;4078.938815917764;4095.1195492969155;4145.357469592218;352043;355888.99999999744;355946;356011;356820;33544.83227583847;34586;59897.70051149716;60374.26444487766;60522.69738651367;36127.27745445076;36481.27037459236;36482.63517364846;36488.81755591258;36490.270194595956;14155.85844141566;14294.571162865132;14301;14301.713965720835;14304.499342522962;10041.19670426364;10699.518521666543;10702.411367374869;10714.142868570496;10732.141428685687;7675.577843218676;7987.720429784929;8221.671133154727;8263.851398636398;8285.254327110468;3136.5922430083942;3165.841707914595;3192.5530425740417;3213.9839300803346;3234.7897386669792;986.4278718343344;1028.6348346336943;1078.8100156681949;1094.1192340166242;1138.9487473063732;31436.685633143832;31866.840665796524;32794.50808237879;32926.506102408486;32975;1077.7790552936629;1099.2360309584762;1103.7461383881753;1117.1174771930084;1128.2948157401624;16039.278232479566;16811;16827;16886;16962.660746784994;581779;588195;588462;588710;589916;57126.7143664279;57846;58081.70959145177;58105;58191.4180858186;1210.5339444314002;1220.8290839282508;1303.7522870654734;1346.6700658338573;1365.863413658626;28449;32864.50703239501;32967.50548741723;33036.834815825765;33519.83240083784;49989.500104998486;50592.241116382545;50814;50868;50881;406666;409896.55465503526;410085;410135;412563;26626.934922603654;27772.306677130735;27832.304192395353;27904.16287511378;27929;45772.31341529813;45856;46214.075718486114;46692.7665361671;46873.296900547204;39013.60986390214;39468.80265598654;40073.39522931;40249.798751006056;41284.79357603313;39251.60748392594;39256.60743392644;39699.80150099231;40218.39672404975;41120;38549;38663.613363866;39413.80293098516;40223;40399.7980010098;32434.67565324411;35283;35306.64693353033;35468.46797298094;35796.821015894755;25845.612315814902;25956.61065084063;26096.347591309608;26222.475550489264;26476.602850957635 16:25:11 INFO - PROCESS | 9817 | |2;jquery.html;367.60482481332576;378.3435738992847;387.25260247721906;397.7414680457703;415.41219174867564;13727.195471645597;14142.787858182135;16159.515214543568;19490.610187796236;19722.534683164606;17719.202635881386;18234;18337.266509339643;18966.90516547419;18993.240270389168;5111.361079865017;5311.681299122046;5314.388845282784;5315.096433606296;5317.654352467077;4554.385158003677;5153.814622636796;5314.070037743399;5349;5373.3014708088085;5297;5363.088274993261;5365.08793505105;5369.6509726867625;5371.248025276464;5140.228965655163;5243.370795504545;5253.711045892474;5278.155495120763;5285.841424757245;5126.461721519261;5127.461616530248;5133.794648214067;5147.6654017488745;5149.0731668299695;13984.091034082752;14210.147391156564;14310;14348.282585870666;14353.210573418457;2191.736991561007;2228.5542891421783;2241.0923575951765;2259.9661005084936;2947.204254851178;8908.465492070496;9698.806023879553;10108.747281317952;10156.289059765819;10722.678319650424;1853.7404763333145;1949.9741725275155;1960.1081507913866;1963.3619073801071;1986.1062521865074;81656;83061.58469207675;83508.16491835065;83743.58128209382;84577;10198.33710808795;10573.524191411405;10624;10704.78590428187;10739.677809665722;14589.270536473134;14625.78061329081;14629.634259143606;14633.12201267906;14654;7495.812604684817;7690.423218258653;7756.573388463576;7924.722634707758;7925;6944.4444444444325;6944.479164062715;7330.230325815713;7341.632918354061;7578.248766860439;4360.280553708666;4459.7547134907245;4468.597826195658;4489.932651010237;4598.88502787433;1880.4546681462223;1887.7918132395278;1983.147246683911;2009.4072248686673;2034.8677335973114;877.1842186766241;1009.2632378363835;1028.9022542858415;1044.2533588484118;1063.8297872340388;18380.540486487676;19271.1327990238;20615.38153855387;21188.470288242916;21246.78753212479;954.2270760683869;975.4293738163112;992.5632721602472;1000.174855744014;1033.2302434686208;10502.159827213805;10907;11027.944860275647;11046.502907369188;11048.834267485994;463909;471984;477476;489913;491400;67435.32564674389;77966;95259.52370238105;95714;97733.5339969901;936.8126374724945;1013.0527956360679;1045.1168762395916;1048.3762161513887;1053.952572134256;16919.23863426124;17090;17674.469765907044;18314.09486566159;18329.725054124465;43080.56919430765;43257.56742432661;44017.339739903284;44237.336439952785;44825;55875.16187257276;55900.720496398884;57768.71115644395;58509.70745146247;58949;7188.209296977224;7884.645190966306;7914.5646989413835;8174.83650327002;8247.381446391664;12166.939165304117;12204.755904881675;12277.140600157903;12409.441575129322;13043.608691739262;10752.301100428447;11357.48891299877;11644.184907056764;11742.823857642314;11826.349550774446;10778.676639700821;10902.345859248471;10919.617813376493;11162.832557511807;11266.66200014001;9933.503324833873;10174.949125254327;10227.642032528825;10591.8940810594;11543.88456115428;7285.7814265572115;8265.586720663823;8497.617607207567;8650.264727498234;8897.555122243992;10557.15542756593;10806.621768238074;10827.837582436112;11267.380294083903;11714 16:25:11 INFO - PROCESS | 9817 | |3;mootools.html;1437.0515459796536;1482.029270827608;1534.8618624323808;1692.9068901210428;1702.5062731807777;7127.180374256962;7330.670119844606;7931.603419829007;8482.660693572258;8486.448380855249;7885.881711774314;8128.796780080486;8145.796355091125;8344.874826877602;8347.373946953987;2263.6151854184827;2285.7942785149335;2291.450051987519;2303.1363238785457;2303.3320337102305;2020.4948762809297;2081;2253.5718213539376;2291.472961218921;2312.2485192312565;2207.227470385368;2282.9086836526517;2287.9199228027023;2299.72403311602;2302.4934514406805;2271.137667112968;2275.9317220483413;2297.6668383084443;2298.241580278504;2298.3564601911494;2285.1316499730165;2286.45125169958;2311.711036120485;2311.8150547956125;2318.2349824558023;8338.791530211733;8371.204735550113;8374.623141958626;8401.621927013239;8402.873956890651;5041.344625198701;5167.431582525919;5226.503482169188;5228.895422091537;5231.3199284092825;3140.7801453898237;3253.4957081652146;3291.9177020574675;3351.7151042161445;3352.681495257971;999.9150072243868;1010.13633343491;1011.1051719228462;1032.1948879873635;1052.3054783842704;11408.942955285254;11427.200095993283;11500.25248358854;11521.711957201138;11532.25040372373;4096.1193343431305;4325.52419233884;4341.547025930339;4414.735115893057;4447.599716025573;9073.59168837404;9080.229355275658;9082.318826087938;9087.863682044775;9101.499417531966;5060.165072762953;5062.291279220838;5063.5695965843315;5069.188929771219;5070.974645126751;4610.976945115253;4671.205894997858;4716.221823399169;4739.857804265877;4742.359781429463;3598.460230965376;3630.4224000959616;3647.434647629622;3690.225052738901;3709.629037096269;1037.273908264218;1041.2763129624989;1085.7068591480413;1106.391484683421;1112.3259494460785;860.4622111180512;895.8745775591423;908.3369140527452;912.703371404283;930.3441074042784;5402.810901618424;5459.042283739143;5538.75075621598;5547.11549994009;5587.720613969285;930.5719369090294;941.9481928493861;948.6632245552868;950.0974074628992;950.496236994394;3560.572731272264;3605.2068544920076;3730.1420673245307;3737.551493820759;3865.497485326946;9914;10166.186705063725;10173.694789156338;10298.279120461646;10407.843882341771;9624.085711857362;10123.190144788547;10127.088562029452;10127.39235645849;10130.594776208869;7562.205968373241;7912.841743165104;7914.881276780853;7918.485298455697;7933.6199140257695;5237.554807841376;5311.814086506954;5449.700266485382;5459.590530710133;5594;9057.275417966679;9292.16370526656;9332.440053596805;9362.859557106785;9364.344495885223;9492.715218543455;9540.666076687561;9569.521523923915;9619.27855410833;9644.807103858024;7197.748078817216;7262.273772622695;7320.304571065741;7328.78013659591;7337.009503716929;7882.605869706606;7984.441089123706;8025;8031.919680803117;8033;6830.521863469509;6981.371676549135;7083.68123434457;7205.531640443354;7400.407967362706;7085.9645701773225;7115.53749006313;7177.677004534704;7202.89195662076;7203.8559228816175;6622.205335359788;6675.532712710064;6683.665816709048;6713.093732346071;6750.831229219309;4725.834595789131;4736.265878788793;4776.9761151194025;4805.783739731791;4902.240152776325;4662.2074247378705;4758.214894542361;4787.162246606899;4791.976040119916;4825.203841366135 16:25:11 INFO - PROCESS | 9817 | |4;prototype.html;321.13934655124274;330.70236786891803;338.9779664321819;339.5314466036869;340.198831751226;5105.489451054893;5247.711375874325;5266.447023062571;5347.54545863602;5367.765413954793;5136.512031357024;5231.189165679316;5273.6572122811995;5277.868053298669;5286.286351342577;4122.196171746511;4126.1541384016355;4129.938050929239;4130.5043394792665;4130.8554200602985;3944.9211015779665;4126.381042843567;4136.73111247768;4145.709800313979;4149.190907772985;4110.445089912869;4110.97944510277;4120.793960301988;4130.1739652069555;4134.235166494193;4086.9386959195635;4104.856330028435;4115.156392939441;4118.794060297003;4144.937825932613;3629.310431018098;3633.963660363389;3638.6907112895437;3643.2167084076787;3644.1071937375245;5078.26365177051;5191.247269145991;5197.7920883164625;5211.661242019294;5240.187770895517;4687.742174180453;4690.906181876378;4711.552402521755;4739.123262196505;4739.3601863748645;5401.27082843815;5511.807086751945;5534.640248383883;5535.533083732814;5547.195656629807;3909.257241124177;3948.506436695413;3973.821178046966;3975.940360894589;3984;5707.200991861143;5739.565108722819;5762.366139724627;5765.827025189251;5766.394528574481;4013;4033.274010678106;4035.2534781065597;4038.091429428414;4038.91922161561;3906.2968665639887;4064.4309796628495;4094.815733292009;4132.876013719593;4159.584041595876;4665.300204969281;4678.742669153229;4704.576588107018;4706.482286948433;4735.176956871629;5534.806281780118;5559.610827242054;5563.833085007375;5575.526080283222;5598.496135347838;1357.531651580223;1382.882454991337;1456.6576854439197;1460.5691321060312;1477.8669919707063;917.3074328881652;927.7104824294237;937.9155875971059;946.4321407155652;955.7562821480478;4625.236835922035;4653.325267836145;4686.5782079613;4694.694844835143;4728.527147285313;4931.728754918442;4943.579795717333;4951.5048495150195;4952;4960.801567937314;4565.726056436624;4696.741679207608;4709.740964246999;4759.643501602027;4769.785359658824;2658.9734102659113;2680.833837280789;2691.9327016824736;2692.8249663771794;2695.3531152523647;5011.824586139468;5049.495050494921;5053.9494605054215;5066.214736715815;5084.339035925306;4851.854444366674;4936.950630493721;4973.428055773632;5013.298138260647;5038.606661835599;4969.751512424436;5037.974810125926;5057.397768031074;5064.607233010878;5094.974525127351;4911;4941.234108713155;4948.777305021211;4962.751862406937;5007.424146223231;4716.419999300273;4830.671565319425;4853.830115945925;4882.7558622068045;4899.632527560376;4935;5016.648834581691;5028.64799464034;5030.798768049383;5111.591072714248;3690.7785532868115;3692.298463291966;3704.2591481704308;3717.646823551758;3729.5524537055726;4855.660103792842;4898.652870460509;4903.705777653352;4927.127691477216;5290.68255904647;4980.551750342486;5503.2020357048805;5514.834554963358;5532.838103998205;5536.4186760389575;5501.889962200814;5524;5544.3346798384455;5562.0266453371305;5582.720863956704;5321.494458026481;5494.945050549443;5545.556355491471;5568.276124103841;5575.769692123184;5504.697241651747;5507.788286576947;5578.804741834017;5587.441255874543;5609.242752228397;5457.345118585795;5469.75386107634;5502.789386335;5513.641613295123;5522.723863806874 16:25:11 INFO - PROCESS | 9817 | |5;yui.html;709.8331892005377;718.1131302840994;762.1616222155629;764.2739397572308;782.4561929459027;13516.459341626336;14160.07959482633;14226.644333891645;14245.715085698279;14344.426222951082;13801.309934503284;13891.722165556683;13921.582352529414;13925.93037034816;13959.581212563615;777.1218523068924;793.0602236349944;795.220683729945;795.3517882925427;795.4034474144391;784.8077221080844;787.1931270447808;787.5353541410567;788.1055002572093;788.1999770233218;825.5170725125809;825.9132791056943;826.4215049465369;827.1273806134526;827.8634025385804;823.2220551578761;824.5217773691245;825.0635528674967;825.5995842016617;825.6738588257605;611.8256296955391;612.2408213814882;612.4426771637833;612.583443258584;612.7732738886596;12813.679658008532;13648.317584120754;13814.171149731048;13852.515161969384;13855.445782168701;12389.194702344319;12414.379281035912;12700.110992230548;12858.099933004694;13045.282509461977;10646;10848.566057357697;10921.726956826064;10990.450477476174;11285.774284514264;3623.9456408153897;3624.8187590620364;3685.539307586552;3712.053426376284;3802.8098595070414;58772;59325;59540.40459595392;60114.699426502586;62400;9384.436933783994;9520.428774273427;9601.615935362646;9647.9035209647;9810.460424676568;17752.46742597724;17825.910870445823;17920.731189032176;17936;17941.192646330946;5449.782008719686;7198.604076775723;7917.327027202752;8281.254687078072;8526.531040792692;4414.738372961769;4490.07953369565;4490.371348011281;4520.344550040226;4685.273782563708;3285.819279939626;3382.2220889195623;3384.3738908302043;3391.3047825195777;3396.184915620283;590.748931704024;595.2945759275186;595.7289433307834;598.3956204233668;602.301330456677;665.5873358517654;701.2881924846286;718.3391280022392;728.5519405565539;739.5119221313907;8969.955150224207;9164.541772911327;9169.541522923828;9459.574319155654;9547.665831695856;626.79629120536;636.2174525333866;666.2305037681485;719.0939416335455;723.9203687594361;4181.226473102486;4466.151431228056;4518.774061296922;4535.9773201133785;4545.340925565841;87300;87410.56294718485;88698.55650721706;88750;91127.54436227909;76400.61799691078;77869;78743.60628196823;79414.602926985;79624;53657.463425366026;55270;56306.15540766892;59989.40010599838;61000;8867.911320886966;9181.724548263563;9267.44395336282;9386.249100071842;9399.107084827205;41409;41613.79193104015;42392;42868.78565607152;43704.344434834136;54167.18749218686;54411;57742.42257577539;58211.4178858206;59556.70221648864;11415.429228538706;11755.529778808752;11839.526418943145;12106.636800895987;12477.563285284972;13629.727405452033;13657.112287701268;13905.72188556203;14127.15237085778;14137.222452765196;13120;13246.277983862035;13390;13430;13540.119892206974;11344.659660210207;11513.338319621042;11714.531418743496;11794.46924888365;11803.586874459354;12604.810927836274;13051.216926984032;13215.339233038501;13365;14197.574072777834;10055.648052318134;10092.192624590161;10357.171426285728;10443.425611591436;10903.454827258447;10501.212409069198;10752.13982881352;10851.782964340828;10923.12614990783;10946.56213751473 16:25:11 INFO - PROCESS | 9817 | __end_tp_report 16:25:11 INFO - PROCESS | 9817 | __start_cc_report 16:25:11 INFO - PROCESS | 9817 | _x_x_mozilla_cycle_collect,1823 16:25:11 INFO - PROCESS | 9817 | __end_cc_report 16:25:11 INFO - PROCESS | 9817 | __startTimestamp1477869911773__endTimestamp 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | ------- Summary: start ------- 16:25:11 INFO - PROCESS | 9817 | Number of tests: 6 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#0] dojo.html Cycles:165 Average:5368.72 Median:5552.50 stddev:604.68 (10.9%) stddev-sans-first:578.47 16:25:11 INFO - PROCESS | 9817 | Values: 3047.7 3082.1 3108.8 3123.1 3128.4 5279.9 5362.6 5376.3 5436.7 5469.0 5412.9 5420.8 5423.4 5432.3 5450.2 4870.6 4889.7 4905.2 4940.2 4967.6 4952.3 5011.9 5013.2 5013.8 5016.9 4908.2 4946.2 4963.9 4979.2 5013.5 5005.7 5028.0 5034.1 5037.5 5092.2 4787.8 4827.4 4860.3 4921.7 4931.5 5395.1 5407.3 5419.4 5437.3 5501.8 5826.7 5856.6 5861.8 5864.1 5869.1 5634.6 5772.3 5788.5 5905.4 5914.3 5377.7 5416.7 5417.5 5476.2 5483.0 5939.5 5992.6 5992.9 5996.6 5997.1 5396.4 5471.3 5730.7 5734.5 5743.3 5608.9 5648.1 5654.2 5701.0 5752.2 5676.2 5685.3 5729.3 5740.0 5741.5 5605.4 5786.9 5787.7 5788.5 5841.9 4351.0 4356.9 4370.7 4407.7 4409.6 3938.1 3939.1 3943.4 3984.5 3985.3 5498.6 5503.8 5517.2 5519.9 5582.6 5580.2 5620.1 5698.5 5739.5 5851.4 5440.1 5469.9 5487.1 5498.0 5500.5 4949.4 4982.2 4988.0 4988.6 5036.3 5770.5 5838.6 5887.0 5888.8 5905.7 5627.3 5727.1 5752.0 5762.1 5867.6 5960.0 5968.4 5976.9 5981.5 5984.3 5672.1 5685.9 5695.3 5695.6 5695.8 5559.4 5676.7 5777.5 5806.3 5824.9 5674.9 5708.8 5715.8 5731.4 5760.2 5707.2 5711.7 5714.7 5714.8 5717.8 5426.4 5485.5 5501.2 5609.8 5690.0 5657.0 5661.0 5663.5 5665.7 5667.8 5509.1 5522.9 5546.6 5552.5 5557.2 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#1] ext.html Cycles:180 Average:59376.49 Median:355978.50 stddev:122978.37 (34.5%) stddev-sans-first:123244.02 16:25:11 INFO - PROCESS | 9817 | Values: 543.2 592.3 617.4 630.8 641.8 31493.5 41122.4 41991.2 41994.6 42004.8 44189.1 44547.0 44565.6 44665.3 44686.6 7839.8 8793.3 8967.1 8970.1 8976.5 8022.4 8050.4 8051.5 10399.4 10655.9 10774.5 10797.0 10839.0 10842.3 10849.7 10615.2 10617.9 10640.1 10646.1 10657.5 10638.9 10692.7 10707.4 10713.5 10722.1 40974.2 41413.4 41510.8 41689.6 41733.8 3270.9 3281.9 3310.5 3494.3 3545.3 30789.2 31142.0 31167.4 31972.8 32189.8 3995.9 4057.1 4078.9 4095.1 4145.4 352043.0 355889.0 355946.0 356011.0 356820.0 33544.8 34586.0 59897.7 60374.3 60522.7 36127.3 36481.3 36482.6 36488.8 36490.3 14155.9 14294.6 14301.0 14301.7 14304.5 10041.2 10699.5 10702.4 10714.1 10732.1 7675.6 7987.7 8221.7 8263.9 8285.3 3136.6 3165.8 3192.6 3214.0 3234.8 986.4 1028.6 1078.8 1094.1 1138.9 31436.7 31866.8 32794.5 32926.5 32975.0 1077.8 1099.2 1103.7 1117.1 1128.3 16039.3 16811.0 16827.0 16886.0 16962.7 581779.0 588195.0 588462.0 588710.0 589916.0 57126.7 57846.0 58081.7 58105.0 58191.4 1210.5 1220.8 1303.8 1346.7 1365.9 28449.0 32864.5 32967.5 33036.8 33519.8 49989.5 50592.2 50814.0 50868.0 50881.0 406666.0 409896.6 410085.0 410135.0 412563.0 26626.9 27772.3 27832.3 27904.2 27929.0 45772.3 45856.0 46214.1 46692.8 46873.3 39013.6 39468.8 40073.4 40249.8 41284.8 39251.6 39256.6 39699.8 40218.4 41120.0 38549.0 38663.6 39413.8 40223.0 40399.8 32434.7 35283.0 35306.6 35468.5 35796.8 25845.6 25956.6 26096.3 26222.5 26476.6 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#2] jquery.html Cycles:180 Average:28095.38 Median:2603.59 stddev:79113.07 (3038.6%) stddev-sans-first:79307.61 16:25:11 INFO - PROCESS | 9817 | Values: 367.6 378.3 387.3 397.7 415.4 13727.2 14142.8 16159.5 19490.6 19722.5 17719.2 18234.0 18337.3 18966.9 18993.2 5111.4 5311.7 5314.4 5315.1 5317.7 4554.4 5153.8 5314.1 5349.0 5373.3 5297.0 5363.1 5365.1 5369.7 5371.2 5140.2 5243.4 5253.7 5278.2 5285.8 5126.5 5127.5 5133.8 5147.7 5149.1 13984.1 14210.1 14310.0 14348.3 14353.2 2191.7 2228.6 2241.1 2260.0 2947.2 8908.5 9698.8 10108.7 10156.3 10722.7 1853.7 1950.0 1960.1 1963.4 1986.1 81656.0 83061.6 83508.2 83743.6 84577.0 10198.3 10573.5 10624.0 10704.8 10739.7 14589.3 14625.8 14629.6 14633.1 14654.0 7495.8 7690.4 7756.6 7924.7 7925.0 6944.4 6944.5 7330.2 7341.6 7578.2 4360.3 4459.8 4468.6 4489.9 4598.9 1880.5 1887.8 1983.1 2009.4 2034.9 877.2 1009.3 1028.9 1044.3 1063.8 18380.5 19271.1 20615.4 21188.5 21246.8 954.2 975.4 992.6 1000.2 1033.2 10502.2 10907.0 11027.9 11046.5 11048.8 463909.0 471984.0 477476.0 489913.0 491400.0 67435.3 77966.0 95259.5 95714.0 97733.5 936.8 1013.1 1045.1 1048.4 1054.0 16919.2 17090.0 17674.5 18314.1 18329.7 43080.6 43257.6 44017.3 44237.3 44825.0 55875.2 55900.7 57768.7 58509.7 58949.0 7188.2 7884.6 7914.6 8174.8 8247.4 12166.9 12204.8 12277.1 12409.4 13043.6 10752.3 11357.5 11644.2 11742.8 11826.3 10778.7 10902.3 10919.6 11162.8 11266.7 9933.5 10174.9 10227.6 10591.9 11543.9 7285.8 8265.6 8497.6 8650.3 8897.6 10557.2 10806.6 10827.8 11267.4 11714.0 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#3] mootools.html Cycles:180 Average:5426.80 Median:5066.38 stddev:3032.38 (59.9%) stddev-sans-first:3026.06 16:25:11 INFO - PROCESS | 9817 | Values: 1437.1 1482.0 1534.9 1692.9 1702.5 7127.2 7330.7 7931.6 8482.7 8486.4 7885.9 8128.8 8145.8 8344.9 8347.4 2263.6 2285.8 2291.5 2303.1 2303.3 2020.5 2081.0 2253.6 2291.5 2312.2 2207.2 2282.9 2287.9 2299.7 2302.5 2271.1 2275.9 2297.7 2298.2 2298.4 2285.1 2286.5 2311.7 2311.8 2318.2 8338.8 8371.2 8374.6 8401.6 8402.9 5041.3 5167.4 5226.5 5228.9 5231.3 3140.8 3253.5 3291.9 3351.7 3352.7 999.9 1010.1 1011.1 1032.2 1052.3 11408.9 11427.2 11500.3 11521.7 11532.3 4096.1 4325.5 4341.5 4414.7 4447.6 9073.6 9080.2 9082.3 9087.9 9101.5 5060.2 5062.3 5063.6 5069.2 5071.0 4611.0 4671.2 4716.2 4739.9 4742.4 3598.5 3630.4 3647.4 3690.2 3709.6 1037.3 1041.3 1085.7 1106.4 1112.3 860.5 895.9 908.3 912.7 930.3 5402.8 5459.0 5538.8 5547.1 5587.7 930.6 941.9 948.7 950.1 950.5 3560.6 3605.2 3730.1 3737.6 3865.5 9914.0 10166.2 10173.7 10298.3 10407.8 9624.1 10123.2 10127.1 10127.4 10130.6 7562.2 7912.8 7914.9 7918.5 7933.6 5237.6 5311.8 5449.7 5459.6 5594.0 9057.3 9292.2 9332.4 9362.9 9364.3 9492.7 9540.7 9569.5 9619.3 9644.8 7197.7 7262.3 7320.3 7328.8 7337.0 7882.6 7984.4 8025.0 8031.9 8033.0 6830.5 6981.4 7083.7 7205.5 7400.4 7086.0 7115.5 7177.7 7202.9 7203.9 6622.2 6675.5 6683.7 6713.1 6750.8 4725.8 4736.3 4777.0 4805.8 4902.2 4662.2 4758.2 4787.2 4792.0 4825.2 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#4] prototype.html Cycles:180 Average:4440.64 Median:4929.43 stddev:1270.68 (25.8%) stddev-sans-first:1236.06 16:25:11 INFO - PROCESS | 9817 | Values: 321.1 330.7 339.0 339.5 340.2 5105.5 5247.7 5266.4 5347.5 5367.8 5136.5 5231.2 5273.7 5277.9 5286.3 4122.2 4126.2 4129.9 4130.5 4130.9 3944.9 4126.4 4136.7 4145.7 4149.2 4110.4 4111.0 4120.8 4130.2 4134.2 4086.9 4104.9 4115.2 4118.8 4144.9 3629.3 3634.0 3638.7 3643.2 3644.1 5078.3 5191.2 5197.8 5211.7 5240.2 4687.7 4690.9 4711.6 4739.1 4739.4 5401.3 5511.8 5534.6 5535.5 5547.2 3909.3 3948.5 3973.8 3975.9 3984.0 5707.2 5739.6 5762.4 5765.8 5766.4 4013.0 4033.3 4035.3 4038.1 4038.9 3906.3 4064.4 4094.8 4132.9 4159.6 4665.3 4678.7 4704.6 4706.5 4735.2 5534.8 5559.6 5563.8 5575.5 5598.5 1357.5 1382.9 1456.7 1460.6 1477.9 917.3 927.7 937.9 946.4 955.8 4625.2 4653.3 4686.6 4694.7 4728.5 4931.7 4943.6 4951.5 4952.0 4960.8 4565.7 4696.7 4709.7 4759.6 4769.8 2659.0 2680.8 2691.9 2692.8 2695.4 5011.8 5049.5 5053.9 5066.2 5084.3 4851.9 4937.0 4973.4 5013.3 5038.6 4969.8 5038.0 5057.4 5064.6 5095.0 4911.0 4941.2 4948.8 4962.8 5007.4 4716.4 4830.7 4853.8 4882.8 4899.6 4935.0 5016.6 5028.6 5030.8 5111.6 3690.8 3692.3 3704.3 3717.6 3729.6 4855.7 4898.7 4903.7 4927.1 5290.7 4980.6 5503.2 5514.8 5532.8 5536.4 5501.9 5524.0 5544.3 5562.0 5582.7 5321.5 5494.9 5545.6 5568.3 5575.8 5504.7 5507.8 5578.8 5587.4 5609.2 5457.3 5469.8 5502.8 5513.6 5522.7 16:25:11 INFO - PROCESS | 9817 | 16:25:11 INFO - PROCESS | 9817 | [#5] yui.html Cycles:180 Average:16945.54 Median:53912.33 stddev:22554.94 (41.8%) stddev-sans-first:22585.26 16:25:11 INFO - PROCESS | 9817 | Values: 709.8 718.1 762.2 764.3 782.5 13516.5 14160.1 14226.6 14245.7 14344.4 13801.3 13891.7 13921.6 13925.9 13959.6 777.1 793.1 795.2 795.4 795.4 784.8 787.2 787.5 788.1 788.2 825.5 825.9 826.4 827.1 827.9 823.2 824.5 825.1 825.6 825.7 611.8 612.2 612.4 612.6 612.8 12813.7 13648.3 13814.2 13852.5 13855.4 12389.2 12414.4 12700.1 12858.1 13045.3 10646.0 10848.6 10921.7 10990.5 11285.8 3623.9 3624.8 3685.5 3712.1 3802.8 58772.0 59325.0 59540.4 60114.7 62400.0 9384.4 9520.4 9601.6 9647.9 9810.5 17752.5 17825.9 17920.7 17936.0 17941.2 5449.8 7198.6 7917.3 8281.3 8526.5 4414.7 4490.1 4490.4 4520.3 4685.3 3285.8 3382.2 3384.4 3391.3 3396.2 590.7 595.3 595.7 598.4 602.3 665.6 701.3 718.3 728.6 739.5 8970.0 9164.5 9169.5 9459.6 9547.7 626.8 636.2 666.2 719.1 723.9 4181.2 4466.2 4518.8 4536.0 4545.3 87300.0 87410.6 88698.6 88750.0 91127.5 76400.6 77869.0 78743.6 79414.6 79624.0 53657.5 55270.0 56306.2 59989.4 61000.0 8867.9 9181.7 9267.4 9386.2 9399.1 41409.0 41613.8 42392.0 42868.8 43704.3 54167.2 54411.0 57742.4 58211.4 59556.7 11415.4 11755.5 11839.5 12106.6 12477.6 13629.7 13657.1 13905.7 14127.2 14137.2 13120.0 13246.3 13390.0 13430.0 13540.1 11344.7 11513.3 11714.5 11794.5 11803.6 12604.8 13051.2 13215.3 13365.0 14197.6 10055.6 10092.2 10357.2 10443.4 10903.5 10501.2 10752.1 10851.8 10923.1 10946.6 16:25:11 INFO - PROCESS | 9817 | -------- Summary: end -------- 16:25:11 INFO - PROCESS | 9817 | 16:25:12 INFO - TEST-INFO | 9817: exit 0 16:25:12 INFO - TEST-OK | dromaeo_css | took 1117814ms 16:25:12 INFO - TEST-START | kraken 16:25:12 INFO - operating with platform_type : linux_ 16:25:12 INFO - Initialising browser for kraken test... 16:25:12 INFO - TEST-INFO | started process 10133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYqIwY/profile http://localhost:58756/getInfo.html) 16:25:16 INFO - PROCESS | 10133 | __metrics Screen width/height:1600/1200 16:25:16 INFO - PROCESS | 10133 | colorDepth:24 16:25:16 INFO - PROCESS | 10133 | Browser inner width/height: 1024/697 16:25:16 INFO - PROCESS | 10133 | __metrics 16:25:17 INFO - PROCESS | 10133 | 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" 16:25:17 INFO - PROCESS | 10133 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:25:18 INFO - PROCESS | 10133 | console.error: PushService: 16:25:18 INFO - PROCESS | 10133 | stateChangeProcessEnqueue: Error transitioning state 16:25:18 INFO - PROCESS | 10133 | UnknownError 16:25:18 INFO - TEST-INFO | 10133: exit 0 16:25:18 INFO - Browser initialized. 16:25:18 INFO - Running cycle 1/1 for kraken test... 16:25:18 INFO - TEST-INFO | started process 10215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaYqIwY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:30 INFO - PROCESS | 10215 | RSS: Main: 174399488 16:25:30 INFO - PROCESS | 10215 | 16:25:33 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58756/tests/kraken/driver.html?testName=audio-beat-detection) 16:25:34 INFO - PROCESS | 10215 | RSS: Main: 231358464 16:25:34 INFO - PROCESS | 10215 | 16:25:37 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58756/tests/kraken/driver.html?testName=audio-dft) 16:25:37 INFO - PROCESS | 10215 | RSS: Main: 218484736 16:25:37 INFO - PROCESS | 10215 | 16:25:40 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58756/tests/kraken/driver.html?testName=audio-fft) 16:25:41 INFO - PROCESS | 10215 | RSS: Main: 299991040 16:25:41 INFO - PROCESS | 10215 | 16:25:43 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58756/tests/kraken/driver.html?testName=audio-oscillator) 16:25:44 INFO - PROCESS | 10215 | RSS: Main: 209735680 16:25:44 INFO - PROCESS | 10215 | 16:25:46 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58756/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:25:46 INFO - PROCESS | 10215 | RSS: Main: 213966848 16:25:46 INFO - PROCESS | 10215 | 16:25:49 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58756/tests/kraken/driver.html?testName=imaging-darkroom) 16:25:50 INFO - PROCESS | 10215 | RSS: Main: 250413056 16:25:50 INFO - PROCESS | 10215 | 16:25:53 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58756/tests/kraken/driver.html?testName=imaging-desaturate) 16:25:54 INFO - PROCESS | 10215 | RSS: Main: 248356864 16:25:54 INFO - PROCESS | 10215 | 16:25:56 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58756/tests/kraken/driver.html?testName=json-parse-financial) 16:25:57 INFO - PROCESS | 10215 | RSS: Main: 248123392 16:25:57 INFO - PROCESS | 10215 | 16:25:58 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58756/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:25:59 INFO - PROCESS | 10215 | RSS: Main: 210804736 16:25:59 INFO - PROCESS | 10215 | 16:26:01 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:26:01 INFO - PROCESS | 10215 | RSS: Main: 218300416 16:26:01 INFO - PROCESS | 10215 | 16:26:04 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:26:04 INFO - PROCESS | 10215 | RSS: Main: 227614720 16:26:04 INFO - PROCESS | 10215 | 16:26:07 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:26:08 INFO - PROCESS | 10215 | RSS: Main: 236658688 16:26:08 INFO - PROCESS | 10215 | 16:26:10 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:26:11 INFO - PROCESS | 10215 | RSS: Main: 233594880 16:26:11 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | Cycle 1(1): loaded http://localhost:58756/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58756/tests/kraken/driver.html?testName=ai-astar) 16:26:13 INFO - PROCESS | 10215 | RSS: Main: 284532736 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | __start_tp_report 16:26:13 INFO - PROCESS | 10215 | _x_x_mozilla_page_load 16:26:13 INFO - PROCESS | 10215 | _x_x_mozilla_page_load_details 16:26:13 INFO - PROCESS | 10215 | |i|pagename|runs| 16:26:13 INFO - PROCESS | 10215 | |0;ai-astar;104;112;112;111;112;112;112;111;113;111 16:26:13 INFO - PROCESS | 10215 | |1;audio-beat-detection;147;121;122;170;130;124;129;122;156;124 16:26:13 INFO - PROCESS | 10215 | |2;audio-dft;161;160;160;161;167;161;162;163;160;161 16:26:13 INFO - PROCESS | 10215 | |3;audio-fft;73;76;74;108;76;75;75;76;97;75 16:26:13 INFO - PROCESS | 10215 | |4;audio-oscillator;82;81;117;83;82;82;103;82;82;118 16:26:13 INFO - PROCESS | 10215 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;117 16:26:13 INFO - PROCESS | 10215 | |6;imaging-darkroom;145;146;147;146;145;145;145;147;146;145 16:26:13 INFO - PROCESS | 10215 | |7;imaging-desaturate;85;85;84;84;84;85;84;84;84;84 16:26:13 INFO - PROCESS | 10215 | |8;json-parse-financial;56;55;57;55;55;56;58;57;57;59 16:26:13 INFO - PROCESS | 10215 | |9;json-stringify-tinderbox;60;62;61;61;61;60;61;61;62;61 16:26:13 INFO - PROCESS | 10215 | |10;stanford-crypto-aes;88;88;84;87;85;78;84;79;79;79 16:26:13 INFO - PROCESS | 10215 | |11;stanford-crypto-ccm;137;133;134;131;129;139;128;131;170;140 16:26:13 INFO - PROCESS | 10215 | |12;stanford-crypto-pbkdf2;164;172;165;166;164;164;165;164;164;167 16:26:13 INFO - PROCESS | 10215 | |13;stanford-crypto-sha256-iterative;65;72;62;63;63;66;63;66;62;62 16:26:13 INFO - PROCESS | 10215 | __end_tp_report 16:26:13 INFO - PROCESS | 10215 | __start_cc_report 16:26:13 INFO - PROCESS | 10215 | _x_x_mozilla_cycle_collect,1711 16:26:13 INFO - PROCESS | 10215 | __end_cc_report 16:26:13 INFO - PROCESS | 10215 | __startTimestamp1477869973278__endTimestamp 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | ------- Summary: start ------- 16:26:13 INFO - PROCESS | 10215 | Number of tests: 14 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.54 (2.3%) stddev-sans-first:0.67 16:26:13 INFO - PROCESS | 10215 | Values: 104.0 112.0 112.0 111.0 112.0 112.0 112.0 111.0 113.0 111.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:129.50 stddev:17.14 (13.2%) stddev-sans-first:17.57 16:26:13 INFO - PROCESS | 10215 | Values: 147.0 121.0 122.0 170.0 130.0 124.0 129.0 122.0 156.0 124.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 16:26:13 INFO - PROCESS | 10215 | Values: 161.0 160.0 160.0 161.0 167.0 161.0 162.0 163.0 160.0 161.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.50 stddev:11.92 (15.8%) stddev-sans-first:12.33 16:26:13 INFO - PROCESS | 10215 | Values: 73.0 76.0 74.0 108.0 76.0 75.0 75.0 76.0 97.0 75.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.00 stddev:15.34 (18.7%) stddev-sans-first:15.90 16:26:13 INFO - PROCESS | 10215 | Values: 82.0 81.0 117.0 83.0 82.0 82.0 103.0 82.0 82.0 118.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:26:13 INFO - PROCESS | 10215 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 16:26:13 INFO - PROCESS | 10215 | Values: 145.0 146.0 147.0 146.0 145.0 145.0 145.0 147.0 146.0 145.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 16:26:13 INFO - PROCESS | 10215 | Values: 85.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:1.35 (2.4%) stddev-sans-first:1.42 16:26:13 INFO - PROCESS | 10215 | Values: 56.0 55.0 57.0 55.0 55.0 56.0 58.0 57.0 57.0 59.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.67 (1.1%) stddev-sans-first:0.60 16:26:13 INFO - PROCESS | 10215 | Values: 60.0 62.0 61.0 61.0 61.0 60.0 61.0 61.0 62.0 61.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.50 stddev:4.01 (4.7%) stddev-sans-first:3.84 16:26:13 INFO - PROCESS | 10215 | Values: 88.0 88.0 84.0 87.0 85.0 78.0 84.0 79.0 79.0 79.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:135.50 stddev:12.22 (9.0%) stddev-sans-first:12.96 16:26:13 INFO - PROCESS | 10215 | Values: 137.0 133.0 134.0 131.0 129.0 139.0 128.0 131.0 170.0 140.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.00 stddev:2.51 (1.5%) stddev-sans-first:2.60 16:26:13 INFO - PROCESS | 10215 | Values: 164.0 172.0 165.0 166.0 164.0 164.0 165.0 164.0 164.0 167.0 16:26:13 INFO - PROCESS | 10215 | 16:26:13 INFO - PROCESS | 10215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:3.10 (4.8%) stddev-sans-first:3.28 16:26:13 INFO - PROCESS | 10215 | Values: 65.0 72.0 62.0 63.0 63.0 66.0 63.0 66.0 62.0 62.0 16:26:13 INFO - PROCESS | 10215 | -------- Summary: end -------- 16:26:13 INFO - PROCESS | 10215 | 16:26:14 INFO - TEST-INFO | 10215: exit 0 16:26:14 INFO - TEST-OK | kraken | took 61833ms 16:26:14 INFO - SUITE-END | took 1179s 16:26:14 INFO - Completed test suite (00:19:40) 16:26:14 INFO - javascript benchmark 16:26:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3047.7257046865784, 3082.0599717086307, 3108.797928134671, 3123.1411361875494, 3128.374325134974, 5279.947200527993, 5362.570994320455, 5376.327959005124, 5436.700981446019, 5468.972655136724, 5412.891742165154, 5420.810271640484, 5423.430539793324, 5432.348118225808, 5450.155225939976, 4870.610351171907, 4889.682170658896, 4905.190643543811, 4940.1601727706375, 4967.627427942901, 4952.257161425779, 5011.899762004758, 5013.172826483644, 5013.774380152902, 5016.924746128811, 4908.239222920453, 4946.183879659852, 4963.851084467472, 4979.1784355581285, 5013.473585273548, 5005.724685142316, 5028.0, 5034.11902916988, 5037.5214354636255, 5092.236164575306, 4787.80848766049, 4827.372441582572, 4860.343853579757, 4921.655484116113, 4931.457539670633, 5395.05586522357, 5407.297051383295, 5419.403865574784, 5437.293151890229, 5501.807436739735, 5826.737796799154, 5856.590038697293, 5861.794837180678, 5864.1203819427, 5869.06095024794, 5634.577406694473, 5772.3361813391575, 5788.450097240755, 5905.350411454737, 5914.349421563625, 5377.677339359651, 5416.702081385482, 5417.485338892799, 5476.151196564579, 5482.985647655197, 5939.495142912814, 5992.610480318765, 5992.910106348409, 5996.550258730613, 5997.100434934795, 5396.406395296514, 5471.2887324647545, 5730.656160630376, 5734.455226753452, 5743.282089738783, 5608.859778505488, 5648.096304591246, 5654.208410822488, 5701.0, 5752.165935939349, 5676.176954341598, 5685.289338832646, 5729.312482502127, 5740.0, 5741.540676745851, 5605.383407825136, 5786.913196302059, 5787.739551720183, 5788.479036886701, 5841.853953651193, 4350.956490435118, 4356.891077723082, 4370.737755734666, 4407.669424793154, 4409.625181859514, 3938.074552480165, 3939.0940083780893, 3943.369060950234, 3984.541777695602, 3985.3025720498795, 5498.5876059295715, 5503.807366742145, 5517.227588137664, 5519.917201241985, 5582.609217354746, 5580.1629755537, 5620.1288800236025, 5698.515626171822, 5739.454751798572, 5851.356350801409, 5440.075187218183, 5469.945300547023, 5487.149491828773, 5498.0, 5500.532454741392, 4949.406071271471, 4982.227754698028, 4987.975060124749, 4988.551030407209, 5036.345275114211, 5770.538356931519, 5838.591298609056, 5887.0, 5888.822235552907, 5905.704714764331, 5627.324721033502, 5727.083666613322, 5751.971240143773, 5762.135679648086, 5867.618604790675, 5960.0, 5968.373320801254, 5976.8804623908145, 5981.491573216325, 5984.31180414258, 5672.12082127271, 5685.857853553529, 5695.345035320991, 5695.629784064023, 5695.803881184997, 5559.388467268516, 5676.68778217202, 5777.508911742549, 5806.332271788799, 5824.883502329845, 5674.886502270014, 5708.80019199326, 5715.799947002001, 5731.426857314235, 5760.222369980167, 5707.172459993195, 5711.685857277889, 5714.657120572779, 5714.828555143353, 5717.799877004285, 5426.375966763872, 5485.533729633026, 5501.229827824188, 5609.831705048855, 5690.0, 5657.0, 5661.0, 5663.490285874291, 5665.745041473061, 5667.801626943037, 5509.090999984957, 5522.944770552243, 5546.556275498031, 5552.500274975271, 5557.249771280825], "value": 5327.845208310725, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.2472703290262, 592.2803793391031, 617.367198621413, 630.7792272704551, 641.8459569703273, 31493.527597086035, 41122.38316425256, 41991.160176796446, 41994.58005419945, 42004.78997605015, 44189.139194688556, 44547.0, 44565.55434445655, 44665.330020049725, 44686.553134468646, 7839.843203135933, 8793.252573531257, 8967.103289671046, 8970.071434641552, 8976.46141231525, 8022.3582113431075, 8050.4364694471415, 8051.51690898548, 10399.428031458267, 10655.946720266427, 10774.515146818412, 10797.028267455928, 10839.0, 10842.295250808711, 10849.728756781065, 10615.203859710553, 10617.893821061845, 10640.148788096934, 10646.148308135369, 10657.52041158142, 10638.893611063868, 10692.679219623424, 10707.411092389915, 10713.517891694892, 10722.0886224671, 40974.180516389504, 41413.37879931804, 41510.79244603758, 41689.58310416887, 41733.791331043154, 3270.934581308384, 3281.9015429537153, 3310.470324748029, 3494.318607871466, 3545.308664810363, 30789.15265084102, 31142.0, 31167.37665246705, 31972.840135799404, 32189.83905080483, 3995.9200815983518, 4057.107436363995, 4078.938815917764, 4095.1195492969155, 4145.357469592218, 352043.0, 355888.99999999744, 355946.0, 356011.0, 356820.0, 33544.83227583847, 34586.0, 59897.70051149716, 60374.26444487766, 60522.69738651367, 36127.27745445076, 36481.27037459236, 36482.63517364846, 36488.81755591258, 36490.270194595956, 14155.85844141566, 14294.571162865132, 14301.0, 14301.713965720835, 14304.499342522962, 10041.19670426364, 10699.518521666543, 10702.411367374869, 10714.142868570496, 10732.141428685687, 7675.577843218676, 7987.720429784929, 8221.671133154727, 8263.851398636398, 8285.254327110468, 3136.5922430083942, 3165.841707914595, 3192.5530425740417, 3213.9839300803346, 3234.7897386669792, 986.4278718343344, 1028.6348346336943, 1078.8100156681949, 1094.1192340166242, 1138.9487473063732, 31436.685633143832, 31866.840665796524, 32794.50808237879, 32926.506102408486, 32975.0, 1077.7790552936629, 1099.2360309584762, 1103.7461383881753, 1117.1174771930084, 1128.2948157401624, 16039.278232479566, 16811.0, 16827.0, 16886.0, 16962.660746784994, 581779.0, 588195.0, 588462.0, 588710.0, 589916.0, 57126.7143664279, 57846.0, 58081.70959145177, 58105.0, 58191.4180858186, 1210.5339444314002, 1220.8290839282508, 1303.7522870654734, 1346.6700658338573, 1365.863413658626, 28449.0, 32864.50703239501, 32967.50548741723, 33036.834815825765, 33519.83240083784, 49989.500104998486, 50592.241116382545, 50814.0, 50868.0, 50881.0, 406666.0, 409896.55465503526, 410085.0, 410135.0, 412563.0, 26626.934922603654, 27772.306677130735, 27832.304192395353, 27904.16287511378, 27929.0, 45772.31341529813, 45856.0, 46214.075718486114, 46692.7665361671, 46873.296900547204, 39013.60986390214, 39468.80265598654, 40073.39522931, 40249.798751006056, 41284.79357603313, 39251.60748392594, 39256.60743392644, 39699.80150099231, 40218.39672404975, 41120.0, 38549.0, 38663.613363866, 39413.80293098516, 40223.0, 40399.7980010098, 32434.67565324411, 35283.0, 35306.64693353033, 35468.46797298094, 35796.821015894755, 25845.612315814902, 25956.61065084063, 26096.347591309608, 26222.475550489264, 26476.602850957635], "value": 18724.89297332619, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.60482481332576, 378.3435738992847, 387.25260247721906, 397.7414680457703, 415.41219174867564, 13727.195471645597, 14142.787858182135, 16159.515214543568, 19490.610187796236, 19722.534683164606, 17719.202635881386, 18234.0, 18337.266509339643, 18966.90516547419, 18993.240270389168, 5111.361079865017, 5311.681299122046, 5314.388845282784, 5315.096433606296, 5317.654352467077, 4554.385158003677, 5153.814622636796, 5314.070037743399, 5349.0, 5373.3014708088085, 5297.0, 5363.088274993261, 5365.08793505105, 5369.6509726867625, 5371.248025276464, 5140.228965655163, 5243.370795504545, 5253.711045892474, 5278.155495120763, 5285.841424757245, 5126.461721519261, 5127.461616530248, 5133.794648214067, 5147.6654017488745, 5149.0731668299695, 13984.091034082752, 14210.147391156564, 14310.0, 14348.282585870666, 14353.210573418457, 2191.736991561007, 2228.5542891421783, 2241.0923575951765, 2259.9661005084936, 2947.204254851178, 8908.465492070496, 9698.806023879553, 10108.747281317952, 10156.289059765819, 10722.678319650424, 1853.7404763333145, 1949.9741725275155, 1960.1081507913866, 1963.3619073801071, 1986.1062521865074, 81656.0, 83061.58469207675, 83508.16491835065, 83743.58128209382, 84577.0, 10198.33710808795, 10573.524191411405, 10624.0, 10704.78590428187, 10739.677809665722, 14589.270536473134, 14625.78061329081, 14629.634259143606, 14633.12201267906, 14654.0, 7495.812604684817, 7690.423218258653, 7756.573388463576, 7924.722634707758, 7925.0, 6944.4444444444325, 6944.479164062715, 7330.230325815713, 7341.632918354061, 7578.248766860439, 4360.280553708666, 4459.7547134907245, 4468.597826195658, 4489.932651010237, 4598.88502787433, 1880.4546681462223, 1887.7918132395278, 1983.147246683911, 2009.4072248686673, 2034.8677335973114, 877.1842186766241, 1009.2632378363835, 1028.9022542858415, 1044.2533588484118, 1063.8297872340388, 18380.540486487676, 19271.1327990238, 20615.38153855387, 21188.470288242916, 21246.78753212479, 954.2270760683869, 975.4293738163112, 992.5632721602472, 1000.174855744014, 1033.2302434686208, 10502.159827213805, 10907.0, 11027.944860275647, 11046.502907369188, 11048.834267485994, 463909.0, 471984.0, 477476.0, 489913.0, 491400.0, 67435.32564674389, 77966.0, 95259.52370238105, 95714.0, 97733.5339969901, 936.8126374724945, 1013.0527956360679, 1045.1168762395916, 1048.3762161513887, 1053.952572134256, 16919.23863426124, 17090.0, 17674.469765907044, 18314.09486566159, 18329.725054124465, 43080.56919430765, 43257.56742432661, 44017.339739903284, 44237.336439952785, 44825.0, 55875.16187257276, 55900.720496398884, 57768.71115644395, 58509.70745146247, 58949.0, 7188.209296977224, 7884.645190966306, 7914.5646989413835, 8174.83650327002, 8247.381446391664, 12166.939165304117, 12204.755904881675, 12277.140600157903, 12409.441575129322, 13043.608691739262, 10752.301100428447, 11357.48891299877, 11644.184907056764, 11742.823857642314, 11826.349550774446, 10778.676639700821, 10902.345859248471, 10919.617813376493, 11162.832557511807, 11266.66200014001, 9933.503324833873, 10174.949125254327, 10227.642032528825, 10591.8940810594, 11543.88456115428, 7285.7814265572115, 8265.586720663823, 8497.617607207567, 8650.264727498234, 8897.555122243992, 10557.15542756593, 10806.621768238074, 10827.837582436112, 11267.380294083903, 11714.0], "value": 8787.469791356856, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.0515459796536, 1482.029270827608, 1534.8618624323808, 1692.9068901210428, 1702.5062731807777, 7127.180374256962, 7330.670119844606, 7931.603419829007, 8482.660693572258, 8486.448380855249, 7885.881711774314, 8128.796780080486, 8145.796355091125, 8344.874826877602, 8347.373946953987, 2263.6151854184827, 2285.7942785149335, 2291.450051987519, 2303.1363238785457, 2303.3320337102305, 2020.4948762809297, 2081.0, 2253.5718213539376, 2291.472961218921, 2312.2485192312565, 2207.227470385368, 2282.9086836526517, 2287.9199228027023, 2299.72403311602, 2302.4934514406805, 2271.137667112968, 2275.9317220483413, 2297.6668383084443, 2298.241580278504, 2298.3564601911494, 2285.1316499730165, 2286.45125169958, 2311.711036120485, 2311.8150547956125, 2318.2349824558023, 8338.791530211733, 8371.204735550113, 8374.623141958626, 8401.621927013239, 8402.873956890651, 5041.344625198701, 5167.431582525919, 5226.503482169188, 5228.895422091537, 5231.3199284092825, 3140.7801453898237, 3253.4957081652146, 3291.9177020574675, 3351.7151042161445, 3352.681495257971, 999.9150072243868, 1010.13633343491, 1011.1051719228462, 1032.1948879873635, 1052.3054783842704, 11408.942955285254, 11427.200095993283, 11500.25248358854, 11521.711957201138, 11532.25040372373, 4096.1193343431305, 4325.52419233884, 4341.547025930339, 4414.735115893057, 4447.599716025573, 9073.59168837404, 9080.229355275658, 9082.318826087938, 9087.863682044775, 9101.499417531966, 5060.165072762953, 5062.291279220838, 5063.5695965843315, 5069.188929771219, 5070.974645126751, 4610.976945115253, 4671.205894997858, 4716.221823399169, 4739.857804265877, 4742.359781429463, 3598.460230965376, 3630.4224000959616, 3647.434647629622, 3690.225052738901, 3709.629037096269, 1037.273908264218, 1041.2763129624989, 1085.7068591480413, 1106.391484683421, 1112.3259494460785, 860.4622111180512, 895.8745775591423, 908.3369140527452, 912.703371404283, 930.3441074042784, 5402.810901618424, 5459.042283739143, 5538.75075621598, 5547.11549994009, 5587.720613969285, 930.5719369090294, 941.9481928493861, 948.6632245552868, 950.0974074628992, 950.496236994394, 3560.572731272264, 3605.2068544920076, 3730.1420673245307, 3737.551493820759, 3865.497485326946, 9914.0, 10166.186705063725, 10173.694789156338, 10298.279120461646, 10407.843882341771, 9624.085711857362, 10123.190144788547, 10127.088562029452, 10127.39235645849, 10130.594776208869, 7562.205968373241, 7912.841743165104, 7914.881276780853, 7918.485298455697, 7933.6199140257695, 5237.554807841376, 5311.814086506954, 5449.700266485382, 5459.590530710133, 5594.0, 9057.275417966679, 9292.16370526656, 9332.440053596805, 9362.859557106785, 9364.344495885223, 9492.715218543455, 9540.666076687561, 9569.521523923915, 9619.27855410833, 9644.807103858024, 7197.748078817216, 7262.273772622695, 7320.304571065741, 7328.78013659591, 7337.009503716929, 7882.605869706606, 7984.441089123706, 8025.0, 8031.919680803117, 8033.0, 6830.521863469509, 6981.371676549135, 7083.68123434457, 7205.531640443354, 7400.407967362706, 7085.9645701773225, 7115.53749006313, 7177.677004534704, 7202.89195662076, 7203.8559228816175, 6622.205335359788, 6675.532712710064, 6683.665816709048, 6713.093732346071, 6750.831229219309, 4725.834595789131, 4736.265878788793, 4776.9761151194025, 4805.783739731791, 4902.240152776325, 4662.2074247378705, 4758.214894542361, 4787.162246606899, 4791.976040119916, 4825.203841366135], "value": 4368.756462334298, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.13934655124274, 330.70236786891803, 338.9779664321819, 339.5314466036869, 340.198831751226, 5105.489451054893, 5247.711375874325, 5266.447023062571, 5347.54545863602, 5367.765413954793, 5136.512031357024, 5231.189165679316, 5273.6572122811995, 5277.868053298669, 5286.286351342577, 4122.196171746511, 4126.1541384016355, 4129.938050929239, 4130.5043394792665, 4130.8554200602985, 3944.9211015779665, 4126.381042843567, 4136.73111247768, 4145.709800313979, 4149.190907772985, 4110.445089912869, 4110.97944510277, 4120.793960301988, 4130.1739652069555, 4134.235166494193, 4086.9386959195635, 4104.856330028435, 4115.156392939441, 4118.794060297003, 4144.937825932613, 3629.310431018098, 3633.963660363389, 3638.6907112895437, 3643.2167084076787, 3644.1071937375245, 5078.26365177051, 5191.247269145991, 5197.7920883164625, 5211.661242019294, 5240.187770895517, 4687.742174180453, 4690.906181876378, 4711.552402521755, 4739.123262196505, 4739.3601863748645, 5401.27082843815, 5511.807086751945, 5534.640248383883, 5535.533083732814, 5547.195656629807, 3909.257241124177, 3948.506436695413, 3973.821178046966, 3975.940360894589, 3984.0, 5707.200991861143, 5739.565108722819, 5762.366139724627, 5765.827025189251, 5766.394528574481, 4013.0, 4033.274010678106, 4035.2534781065597, 4038.091429428414, 4038.91922161561, 3906.2968665639887, 4064.4309796628495, 4094.815733292009, 4132.876013719593, 4159.584041595876, 4665.300204969281, 4678.742669153229, 4704.576588107018, 4706.482286948433, 4735.176956871629, 5534.806281780118, 5559.610827242054, 5563.833085007375, 5575.526080283222, 5598.496135347838, 1357.531651580223, 1382.882454991337, 1456.6576854439197, 1460.5691321060312, 1477.8669919707063, 917.3074328881652, 927.7104824294237, 937.9155875971059, 946.4321407155652, 955.7562821480478, 4625.236835922035, 4653.325267836145, 4686.5782079613, 4694.694844835143, 4728.527147285313, 4931.728754918442, 4943.579795717333, 4951.5048495150195, 4952.0, 4960.801567937314, 4565.726056436624, 4696.741679207608, 4709.740964246999, 4759.643501602027, 4769.785359658824, 2658.9734102659113, 2680.833837280789, 2691.9327016824736, 2692.8249663771794, 2695.3531152523647, 5011.824586139468, 5049.495050494921, 5053.9494605054215, 5066.214736715815, 5084.339035925306, 4851.854444366674, 4936.950630493721, 4973.428055773632, 5013.298138260647, 5038.606661835599, 4969.751512424436, 5037.974810125926, 5057.397768031074, 5064.607233010878, 5094.974525127351, 4911.0, 4941.234108713155, 4948.777305021211, 4962.751862406937, 5007.424146223231, 4716.419999300273, 4830.671565319425, 4853.830115945925, 4882.7558622068045, 4899.632527560376, 4935.0, 5016.648834581691, 5028.64799464034, 5030.798768049383, 5111.591072714248, 3690.7785532868115, 3692.298463291966, 3704.2591481704308, 3717.646823551758, 3729.5524537055726, 4855.660103792842, 4898.652870460509, 4903.705777653352, 4927.127691477216, 5290.68255904647, 4980.551750342486, 5503.2020357048805, 5514.834554963358, 5532.838103998205, 5536.4186760389575, 5501.889962200814, 5524.0, 5544.3346798384455, 5562.0266453371305, 5582.720863956704, 5321.494458026481, 5494.945050549443, 5545.556355491471, 5568.276124103841, 5575.769692123184, 5504.697241651747, 5507.788286576947, 5578.804741834017, 5587.441255874543, 5609.242752228397, 5457.345118585795, 5469.75386107634, 5502.789386335, 5513.641613295123, 5522.723863806874], "value": 4044.2365078760154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.8331892005377, 718.1131302840994, 762.1616222155629, 764.2739397572308, 782.4561929459027, 13516.459341626336, 14160.07959482633, 14226.644333891645, 14245.715085698279, 14344.426222951082, 13801.309934503284, 13891.722165556683, 13921.582352529414, 13925.93037034816, 13959.581212563615, 777.1218523068924, 793.0602236349944, 795.220683729945, 795.3517882925427, 795.4034474144391, 784.8077221080844, 787.1931270447808, 787.5353541410567, 788.1055002572093, 788.1999770233218, 825.5170725125809, 825.9132791056943, 826.4215049465369, 827.1273806134526, 827.8634025385804, 823.2220551578761, 824.5217773691245, 825.0635528674967, 825.5995842016617, 825.6738588257605, 611.8256296955391, 612.2408213814882, 612.4426771637833, 612.583443258584, 612.7732738886596, 12813.679658008532, 13648.317584120754, 13814.171149731048, 13852.515161969384, 13855.445782168701, 12389.194702344319, 12414.379281035912, 12700.110992230548, 12858.099933004694, 13045.282509461977, 10646.0, 10848.566057357697, 10921.726956826064, 10990.450477476174, 11285.774284514264, 3623.9456408153897, 3624.8187590620364, 3685.539307586552, 3712.053426376284, 3802.8098595070414, 58772.0, 59325.0, 59540.40459595392, 60114.699426502586, 62400.0, 9384.436933783994, 9520.428774273427, 9601.615935362646, 9647.9035209647, 9810.460424676568, 17752.46742597724, 17825.910870445823, 17920.731189032176, 17936.0, 17941.192646330946, 5449.782008719686, 7198.604076775723, 7917.327027202752, 8281.254687078072, 8526.531040792692, 4414.738372961769, 4490.07953369565, 4490.371348011281, 4520.344550040226, 4685.273782563708, 3285.819279939626, 3382.2220889195623, 3384.3738908302043, 3391.3047825195777, 3396.184915620283, 590.748931704024, 595.2945759275186, 595.7289433307834, 598.3956204233668, 602.301330456677, 665.5873358517654, 701.2881924846286, 718.3391280022392, 728.5519405565539, 739.5119221313907, 8969.955150224207, 9164.541772911327, 9169.541522923828, 9459.574319155654, 9547.665831695856, 626.79629120536, 636.2174525333866, 666.2305037681485, 719.0939416335455, 723.9203687594361, 4181.226473102486, 4466.151431228056, 4518.774061296922, 4535.9773201133785, 4545.340925565841, 87300.0, 87410.56294718485, 88698.55650721706, 88750.0, 91127.54436227909, 76400.61799691078, 77869.0, 78743.60628196823, 79414.602926985, 79624.0, 53657.463425366026, 55270.0, 56306.15540766892, 59989.40010599838, 61000.0, 8867.911320886966, 9181.724548263563, 9267.44395336282, 9386.249100071842, 9399.107084827205, 41409.0, 41613.79193104015, 42392.0, 42868.78565607152, 43704.344434834136, 54167.18749218686, 54411.0, 57742.42257577539, 58211.4178858206, 59556.70221648864, 11415.429228538706, 11755.529778808752, 11839.526418943145, 12106.636800895987, 12477.563285284972, 13629.727405452033, 13657.112287701268, 13905.72188556203, 14127.15237085778, 14137.222452765196, 13120.0, 13246.277983862035, 13390.0, 13430.0, 13540.119892206974, 11344.659660210207, 11513.338319621042, 11714.531418743496, 11794.46924888365, 11803.586874459354, 12604.810927836274, 13051.216926984032, 13215.339233038501, 13365.0, 14197.574072777834, 10055.648052318134, 10092.192624590161, 10357.171426285728, 10443.425611591436, 10903.454827258447, 10501.212409069198, 10752.13982881352, 10851.782964340828, 10923.12614990783, 10946.56213751473], "value": 6855.060938020321, "unit": "score"}], "name": "dromaeo_css", "value": 6881.466736666483, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 111.0, 112.0, 112.0, 112.0, 111.0, 113.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 121.0, 122.0, 170.0, 130.0, 124.0, 129.0, 122.0, 156.0, 124.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 167.0, 161.0, 162.0, 163.0, 160.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 108.0, 76.0, 75.0, 75.0, 76.0, 97.0, 75.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 83.0, 82.0, 82.0, 103.0, 82.0, 82.0, 118.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 147.0, 146.0, 145.0, 145.0, 145.0, 147.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 55.0, 55.0, 56.0, 58.0, 57.0, 57.0, 59.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 84.0, 87.0, 85.0, 78.0, 84.0, 79.0, 79.0, 79.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 133.0, 134.0, 131.0, 129.0, 139.0, 128.0, 131.0, 170.0, 140.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 165.0, 166.0, 164.0, 164.0, 165.0, 164.0, 164.0, 167.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 62.0, 63.0, 63.0, 66.0, 63.0, 66.0, 62.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1493.3, "alertThreshold": 2.0}]} 16:26:15 INFO - Return code: 0 16:26:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:26:15 INFO - # TBPL SUCCESS # 16:26:15 INFO - Running post-action listener: _resource_record_post_action 16:26:15 INFO - [mozharness: 2016-10-30 23:26:15.109222Z] Finished run-tests step (success) 16:26:15 INFO - Running post-run listener: _resource_record_post_run 16:26:15 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399790080; Read time: 108; Write time: 433240 16:26:15 INFO - TinderboxPrint: CPU usage
13.2% 16:26:15 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 108 16:26:15 INFO - TinderboxPrint: I/O write bytes / time
399,790,080 / 433,240 16:26:15 INFO - TinderboxPrint: CPU idle
8,298.2 (86.8%) 16:26:15 INFO - TinderboxPrint: CPU user
1,206.0 (12.6%) 16:26:15 INFO - TinderboxPrint: Swap in / out
0 / 0 16:26:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110870528; Read time: 0; Write time: 117440 16:26:15 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 288919552; Read time: 108; Write time: 315800 16:26:15 INFO - Running post-run listener: _upload_blobber_files 16:26:15 INFO - Blob upload gear active. 16:26:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:26:15 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 16:26:15 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:26:15 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:26:16 INFO - (blobuploader) - INFO - Open directory for files ... 16:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:26:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:16 INFO - (blobuploader) - INFO - Done attempting. 16:26:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:26:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:17 INFO - (blobuploader) - INFO - Done attempting. 16:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:26:21 INFO - (blobuploader) - INFO - Done attempting. 16:26:21 INFO - (blobuploader) - INFO - Iteration through files over. 16:26:21 INFO - Return code: 0 16:26:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:26:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:26:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b30203920257c7e8e0bfeae786a98d102b17a883b4b538759e5c38f80e9b7f6501963aacc8e63b7fa69a02d2658438e452c3920d0ffd87ea16e05a6992ca0923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1c135bce4b4b1f566d4dee1872529aeb8a45f28ba9f51919e670c2b6790eaa7526a8ba84975b1df703c8a2498069f9e56c0c362bf418d4b0e826ec060b9e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cbf70034e1f420a7e97542bdd6f709d952c7192bc00c6e60b485240dba75ede0cb633b38b6c3e6532e1b823c2f5da525f042a256a47c0e4cb06efcbd3b43414"} 16:26:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:26:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:26:21 INFO - Contents: 16:26:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b30203920257c7e8e0bfeae786a98d102b17a883b4b538759e5c38f80e9b7f6501963aacc8e63b7fa69a02d2658438e452c3920d0ffd87ea16e05a6992ca0923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1c135bce4b4b1f566d4dee1872529aeb8a45f28ba9f51919e670c2b6790eaa7526a8ba84975b1df703c8a2498069f9e56c0c362bf418d4b0e826ec060b9e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cbf70034e1f420a7e97542bdd6f709d952c7192bc00c6e60b485240dba75ede0cb633b38b6c3e6532e1b823c2f5da525f042a256a47c0e4cb06efcbd3b43414"} 16:26:21 INFO - Running post-run listener: copy_logs_to_upload_dir 16:26:21 INFO - Copying logs to upload dir... 16:26:21 INFO - mkdir: /builds/slave/test/build/upload/logs 16:26:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.460844 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-30 16:26:21.559703) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 16:26:21.560823) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 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/sha512/b30203920257c7e8e0bfeae786a98d102b17a883b4b538759e5c38f80e9b7f6501963aacc8e63b7fa69a02d2658438e452c3920d0ffd87ea16e05a6992ca0923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1c135bce4b4b1f566d4dee1872529aeb8a45f28ba9f51919e670c2b6790eaa7526a8ba84975b1df703c8a2498069f9e56c0c362bf418d4b0e826ec060b9e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cbf70034e1f420a7e97542bdd6f709d952c7192bc00c6e60b485240dba75ede0cb633b38b6c3e6532e1b823c2f5da525f042a256a47c0e4cb06efcbd3b43414"} build_url:https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011369 build_url: 'https://queue.taskcluster.net/v1/task/PU0CtULNRBa9ScA4HJOsSA/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/sha512/b30203920257c7e8e0bfeae786a98d102b17a883b4b538759e5c38f80e9b7f6501963aacc8e63b7fa69a02d2658438e452c3920d0ffd87ea16e05a6992ca0923", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3a1c135bce4b4b1f566d4dee1872529aeb8a45f28ba9f51919e670c2b6790eaa7526a8ba84975b1df703c8a2498069f9e56c0c362bf418d4b0e826ec060b9e9b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5cbf70034e1f420a7e97542bdd6f709d952c7192bc00c6e60b485240dba75ede0cb633b38b6c3e6532e1b823c2f5da525f042a256a47c0e4cb06efcbd3b43414"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 16:26:21.587954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 16:26:21.588642) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1477868737.750126-488832590 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 1.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 16:26:22.712538) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 16:26:22.712879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 16:26:22.716590) ========= ========= Total master_lag: 1.22 =========