builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1475753633.94 results: success (0) buildid: 20161006003024 builduid: a67e732015064e2cafe1a3c78adfb9fb revision: 1d7748535fa370332623ac29e50dd19e1ef6133b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:53.942305) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:53.942796) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:53.943127) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:53.958075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:53.958395) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-06 04:33:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-06 04:33:54 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124084 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:54.096479) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:54.096834) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018410 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:54.145978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 04:33:54.146354) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d7748535fa370332623ac29e50dd19e1ef6133b --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 1d7748535fa370332623ac29e50dd19e1ef6133b --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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-06 04:33:54,717 truncating revision to first 12 chars 2016-10-06 04:33:54,717 Setting DEBUG logging. 2016-10-06 04:33:54,717 attempt 1/10 2016-10-06 04:33:54,718 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d7748535fa3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 04:33:56,055 unpacking tar archive at: fx-team-1d7748535fa3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.748023 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-06 04:33:55.908276) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:55.908651) ========= script_repo_revision: 1d7748535fa370332623ac29e50dd19e1ef6133b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:55.909112) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:55.909461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 04:33:55.920766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 04:33:55.921439) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:33:56 INFO - MultiFileLogger online at 20161006 04:33:56 in /builds/slave/test 04:33:56 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 04:33:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:56 INFO - {'append_to_log': False, 04:33:56 INFO - 'base_work_dir': '/builds/slave/test', 04:33:56 INFO - 'blob_upload_branch': 'Fx-Team', 04:33:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:56 INFO - 'branch': 'Fx-Team', 04:33:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:56 INFO - 'config_files': ('talos/linux_config.py',), 04:33:56 INFO - 'default_actions': ('clobber', 04:33:56 INFO - 'read-buildbot-config', 04:33:56 INFO - 'download-and-extract', 04:33:56 INFO - 'populate-webroot', 04:33:56 INFO - 'create-virtualenv', 04:33:56 INFO - 'install', 04:33:56 INFO - 'run-tests'), 04:33:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:56 INFO - 'download_minidump_stackwalk': True, 04:33:56 INFO - 'download_symbols': 'ondemand', 04:33:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:56 INFO - 'installer_path': 'installer.exe', 04:33:56 INFO - 'log_level': 'info', 04:33:56 INFO - 'log_name': 'talos', 04:33:56 INFO - 'log_to_console': True, 04:33:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:33:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:33:56 INFO - 'opt_config_files': (), 04:33:56 INFO - 'pip_index': False, 04:33:56 INFO - 'sps_profile': False, 04:33:56 INFO - 'sps_profile_interval': 0, 04:33:56 INFO - 'suite': 'dromaeojs', 04:33:56 INFO - 'system_bits': '32', 04:33:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:56 INFO - 'title': 'talos-linux64-ix-066', 04:33:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:56 INFO - 'use_talos_json': True, 04:33:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:56 INFO - 'work_dir': 'build'} 04:33:56 INFO - [mozharness: 2016-10-06 11:33:56.585408Z] Running clobber step. 04:33:56 INFO - Running pre-action listener: _resource_record_pre_action 04:33:56 INFO - Running main action method: clobber 04:33:56 INFO - rmtree: /builds/slave/test/build 04:33:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:57 INFO - Running post-action listener: _resource_record_post_action 04:33:57 INFO - [mozharness: 2016-10-06 11:33:57.044343Z] Finished clobber step (success) 04:33:57 INFO - [mozharness: 2016-10-06 11:33:57.044444Z] Running read-buildbot-config step. 04:33:57 INFO - Running pre-action listener: _resource_record_pre_action 04:33:57 INFO - Running main action method: read_buildbot_config 04:33:57 INFO - Using buildbot properties: 04:33:57 INFO - { 04:33:57 INFO - "project": "", 04:33:57 INFO - "product": "firefox", 04:33:57 INFO - "script_repo_revision": "production", 04:33:57 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:33:57 INFO - "repository": "", 04:33:57 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:33:57 INFO - "buildid": "20161006003024", 04:33:57 INFO - "pgo_build": "True", 04:33:57 INFO - "basedir": "/builds/slave/test", 04:33:57 INFO - "buildnumber": 509, 04:33:57 INFO - "slavename": "talos-linux64-ix-066", 04:33:57 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:33:57 INFO - "platform": "ubuntu64_hw", 04:33:57 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:33:57 INFO - "branch": "fx-team", 04:33:57 INFO - "repo_path": "integration/fx-team", 04:33:57 INFO - "revision": "1d7748535fa370332623ac29e50dd19e1ef6133b", 04:33:57 INFO - "stage_platform": "linux64-pgo", 04:33:57 INFO - "builduid": "a67e732015064e2cafe1a3c78adfb9fb", 04:33:57 INFO - "slavebuilddir": "test" 04:33:57 INFO - } 04:33:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:33:57 INFO - Running post-action listener: _resource_record_post_action 04:33:57 INFO - [mozharness: 2016-10-06 11:33:57.046876Z] Finished read-buildbot-config step (success) 04:33:57 INFO - [mozharness: 2016-10-06 11:33:57.046965Z] Running download-and-extract step. 04:33:57 INFO - Running pre-action listener: _resource_record_pre_action 04:33:57 INFO - Running main action method: download_and_extract 04:33:57 INFO - mkdir: /builds/slave/test/build/tests 04:33: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')]} 04:33:57 INFO - trying https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:57 INFO - Downloading https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:33:57 INFO - Downloaded 1361 bytes. 04:33:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:33:57 INFO - Using the following test package requirements: 04:33:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:33:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:33:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'jsshell-linux-x86_64.zip'], 04:33:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:33:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:33:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:33:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:33:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:33:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:33:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:33:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:33:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:33:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:33:57 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:33:58 INFO - Http code: 200 04:33:58 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 04:33:58 INFO - x-amz-cf-id: TH5CcTyn8fyA1YS0QoHGNRGXqo4U6s8Di-4IBBAxY-ewckE3s_W1kA== 04:33:58 INFO - x-amz-version-id: Rt_cgyMdppAvCJYGJEmVRMDhBHH_Gk2e 04:33:58 INFO - Expected file size: 21993014 04:33:58 INFO - Obtained file size: 21993014 04:34:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:34:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:34:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:34:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:34:03 INFO - Http code: 200 04:34:03 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 04:34:03 INFO - x-amz-cf-id: Q3xeQg9t-NE_17Knvx42oSXNYoa62ddsdgbxitXALwOPyZztdGPbZQ== 04:34:03 INFO - x-amz-version-id: Rt_cgyMdppAvCJYGJEmVRMDhBHH_Gk2e 04:34:03 INFO - Expected file size: 21993014 04:34:03 INFO - Obtained file size: 21993014 04:34:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:34:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:34:07 INFO - Fetch https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:34:08 INFO - Http code: 200 04:34:08 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 04:34:08 INFO - x-amz-cf-id: V-9hmqOrhQ_YxX4v2NqtbjBu8AEDPkImVnAC1CREbq8B0YtpQQWLlA== 04:34:08 INFO - x-amz-version-id: ZeZQzzg5ox6kfGTe6kvd8DYvN8yexp45 04:34:08 INFO - Expected file size: 14409006 04:34:08 INFO - Obtained file size: 14409006 04:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:08 INFO - trying https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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 04:34:09 INFO - Downloaded 59704986 bytes. 04:34:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:34:09 INFO - mkdir: /builds/slave/test/properties 04:34:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:09 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:09 INFO - Contents: 04:34:09 INFO - build_url:https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:34:10 INFO - Running post-action listener: _resource_record_post_action 04:34:10 INFO - Running post-action listener: set_extra_try_arguments 04:34:10 INFO - [mozharness: 2016-10-06 11:34:10.610691Z] Finished download-and-extract step (success) 04:34:10 INFO - [mozharness: 2016-10-06 11:34:10.610916Z] Running populate-webroot step. 04:34:10 INFO - Running pre-action listener: _resource_record_pre_action 04:34:10 INFO - Running main action method: populate_webroot 04:34:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:10 INFO - '--tppagecycles', 04:34:10 INFO - '7'], 04:34:10 INFO - 'tests': ['tsvgm']}}, 04:34:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['damp', 'tps']}, 04:34:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'tests': ['damp', 'tps']}, 04:34:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['dromaeo_dom']}, 04:34:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['basic_compositor_video']}, 04:34:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['a11yr', 04:34:10 INFO - 'ts_paint', 04:34:10 INFO - 'tpaint', 04:34:10 INFO - 'sessionrestore', 04:34:10 INFO - 'sessionrestore_no_auto_restore', 04:34:10 INFO - 'tabpaint']}, 04:34:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['tsvgx', 04:34:10 INFO - 'tsvgr_opacity', 04:34:10 INFO - 'tart', 04:34:10 INFO - 'tscrollx', 04:34:10 INFO - 'cart']}, 04:34:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:10 INFO - 'tsvgr_opacity', 04:34:10 INFO - 'tart', 04:34:10 INFO - 'tscrollx', 04:34:10 INFO - 'cart']}, 04:34:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'talos_options': ['--disable-e10s'], 04:34:10 INFO - 'tests': ['tp5o']}, 04:34:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'tests': ['tp5o']}, 04:34:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'talos_options': ['--disable-e10s', 04:34:10 INFO - '--xperf_path', 04:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:10 INFO - 'tests': ['tp5n']}, 04:34:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:34:10 INFO - 'talos_options': ['--xperf_path', 04:34:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:10 INFO - 'tests': ['tp5n']}}, 04:34:10 INFO - 'talos.zip': {'path': '', 04:34:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:10 INFO - Running post-action listener: _resource_record_post_action 04:34:10 INFO - [mozharness: 2016-10-06 11:34:10.631229Z] Finished populate-webroot step (success) 04:34:10 INFO - [mozharness: 2016-10-06 11:34:10.631363Z] Running create-virtualenv step. 04:34:10 INFO - Running pre-action listener: _resource_record_pre_action 04:34:10 INFO - Running main action method: create_virtualenv 04:34:10 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:10 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 04:34:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:10 INFO - Using real prefix '/usr' 04:34:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:11 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:13 INFO - Installing pip.................done. 04:34:13 INFO - Return code: 0 04:34:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:13 INFO - Reading from file tmpfile_stdout 04:34:13 INFO - Output received: 04:34:13 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) 04:34:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:13 INFO - Using env: {'DISPLAY': ':0', 04:34:13 INFO - 'HOME': '/home/cltbld', 04:34:13 INFO - 'LANG': 'en_US.UTF-8', 04:34:13 INFO - 'LANGUAGE': 'en_US:en', 04:34:13 INFO - 'LOGNAME': 'cltbld', 04:34:13 INFO - 'MAIL': '/var/mail/cltbld', 04:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:13 INFO - 'MOZ_NO_REMOTE': '1', 04:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:13 INFO - 'NO_EM_RESTART': '1', 04:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:13 INFO - 'PWD': '/builds/slave/test', 04:34:13 INFO - 'SHELL': '/bin/bash', 04:34:13 INFO - 'SHLVL': '1', 04:34:13 INFO - 'TERM': 'linux', 04:34:13 INFO - 'TMOUT': '86400', 04:34:13 INFO - 'USER': 'cltbld', 04:34:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:13 INFO - '_': '/tools/buildbot/bin/python'} 04:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:13 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 04:34:13 INFO - Cleaning up... 04:34:13 INFO - Return code: 0 04:34:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:34:13 INFO - Using env: {'DISPLAY': ':0', 04:34:13 INFO - 'HOME': '/home/cltbld', 04:34:13 INFO - 'LANG': 'en_US.UTF-8', 04:34:13 INFO - 'LANGUAGE': 'en_US:en', 04:34:13 INFO - 'LOGNAME': 'cltbld', 04:34:13 INFO - 'MAIL': '/var/mail/cltbld', 04:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:13 INFO - 'MOZ_NO_REMOTE': '1', 04:34:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:13 INFO - 'NO_EM_RESTART': '1', 04:34:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:13 INFO - 'PWD': '/builds/slave/test', 04:34:13 INFO - 'SHELL': '/bin/bash', 04:34:13 INFO - 'SHLVL': '1', 04:34:13 INFO - 'TERM': 'linux', 04:34:13 INFO - 'TMOUT': '86400', 04:34:13 INFO - 'USER': 'cltbld', 04:34:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:13 INFO - '_': '/tools/buildbot/bin/python'} 04:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:13 INFO - Downloading/unpacking psutil>=3.1.1 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34: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 04:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:15 INFO - Installing collected packages: psutil 04:34:15 INFO - Running setup.py install for psutil 04:34:15 INFO - building 'psutil._psutil_linux' extension 04:34:15 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 04:34:16 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 04:34:16 INFO - building 'psutil._psutil_posix' extension 04:34:16 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 04:34:16 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 04:34:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:16 INFO - Successfully installed psutil 04:34:16 INFO - Cleaning up... 04:34:16 INFO - Return code: 0 04:34:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34: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')]} 04:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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')]} 04:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:34: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 mozsystemmonitor==0.3 04:34:16 INFO - Using env: {'DISPLAY': ':0', 04:34:16 INFO - 'HOME': '/home/cltbld', 04:34:16 INFO - 'LANG': 'en_US.UTF-8', 04:34:16 INFO - 'LANGUAGE': 'en_US:en', 04:34:16 INFO - 'LOGNAME': 'cltbld', 04:34:16 INFO - 'MAIL': '/var/mail/cltbld', 04:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:16 INFO - 'MOZ_NO_REMOTE': '1', 04:34:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:16 INFO - 'NO_EM_RESTART': '1', 04:34:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:16 INFO - 'PWD': '/builds/slave/test', 04:34:16 INFO - 'SHELL': '/bin/bash', 04:34:16 INFO - 'SHLVL': '1', 04:34:16 INFO - 'TERM': 'linux', 04:34:16 INFO - 'TMOUT': '86400', 04:34:16 INFO - 'USER': 'cltbld', 04:34:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:16 INFO - '_': '/tools/buildbot/bin/python'} 04:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:16 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 04:34:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:18 INFO - Installing collected packages: mozsystemmonitor 04:34:18 INFO - Running setup.py install for mozsystemmonitor 04:34:18 INFO - Successfully installed mozsystemmonitor 04:34:18 INFO - Cleaning up... 04:34:18 INFO - Return code: 0 04:34:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:34:18 INFO - Using env: {'DISPLAY': ':0', 04:34:18 INFO - 'HOME': '/home/cltbld', 04:34:18 INFO - 'LANG': 'en_US.UTF-8', 04:34:18 INFO - 'LANGUAGE': 'en_US:en', 04:34:18 INFO - 'LOGNAME': 'cltbld', 04:34:18 INFO - 'MAIL': '/var/mail/cltbld', 04:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:18 INFO - 'MOZ_NO_REMOTE': '1', 04:34:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:18 INFO - 'NO_EM_RESTART': '1', 04:34:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:18 INFO - 'PWD': '/builds/slave/test', 04:34:18 INFO - 'SHELL': '/bin/bash', 04:34:18 INFO - 'SHLVL': '1', 04:34:18 INFO - 'TERM': 'linux', 04:34:18 INFO - 'TMOUT': '86400', 04:34:18 INFO - 'USER': 'cltbld', 04:34:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:18 INFO - '_': '/tools/buildbot/bin/python'} 04:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:18 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:21 INFO - warning: no files found matching '*.txt' 04:34:21 INFO - no previously-included directories found matching 'build' 04:34:21 INFO - no previously-included directories found matching 'dist' 04:34:21 INFO - no previously-included directories found matching '.git*' 04:34:21 INFO - Installing collected packages: jsonschema, functools32 04:34:21 INFO - Running setup.py install for functools32 04:34:21 INFO - warning: no files found matching '*.txt' 04:34:21 INFO - no previously-included directories found matching 'build' 04:34:21 INFO - no previously-included directories found matching 'dist' 04:34:21 INFO - no previously-included directories found matching '.git*' 04:34:21 INFO - Successfully installed jsonschema functools32 04:34:21 INFO - Cleaning up... 04:34:21 INFO - Return code: 0 04:34:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:21 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')]} 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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')]} 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:21 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 04:34:21 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 04:34:21 INFO - Using env: {'DISPLAY': ':0', 04:34:21 INFO - 'HOME': '/home/cltbld', 04:34:21 INFO - 'LANG': 'en_US.UTF-8', 04:34:21 INFO - 'LANGUAGE': 'en_US:en', 04:34:21 INFO - 'LOGNAME': 'cltbld', 04:34:21 INFO - 'MAIL': '/var/mail/cltbld', 04:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:21 INFO - 'MOZ_NO_REMOTE': '1', 04:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:21 INFO - 'NO_EM_RESTART': '1', 04:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:21 INFO - 'PWD': '/builds/slave/test', 04:34:21 INFO - 'SHELL': '/bin/bash', 04:34:21 INFO - 'SHLVL': '1', 04:34:21 INFO - 'TERM': 'linux', 04:34:21 INFO - 'TMOUT': '86400', 04:34:21 INFO - 'USER': 'cltbld', 04:34:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:21 INFO - '_': '/tools/buildbot/bin/python'} 04:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:21 INFO - Cleaning up... 04:34:21 INFO - Return code: 0 04:34:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:21 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')]} 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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')]} 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:21 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:21 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 04:34:21 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 04:34:21 INFO - Using env: {'DISPLAY': ':0', 04:34:21 INFO - 'HOME': '/home/cltbld', 04:34:21 INFO - 'LANG': 'en_US.UTF-8', 04:34:21 INFO - 'LANGUAGE': 'en_US:en', 04:34:21 INFO - 'LOGNAME': 'cltbld', 04:34:21 INFO - 'MAIL': '/var/mail/cltbld', 04:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:21 INFO - 'MOZ_NO_REMOTE': '1', 04:34:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:21 INFO - 'NO_EM_RESTART': '1', 04:34:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:21 INFO - 'PWD': '/builds/slave/test', 04:34:21 INFO - 'SHELL': '/bin/bash', 04:34:21 INFO - 'SHLVL': '1', 04:34:21 INFO - 'TERM': 'linux', 04:34:21 INFO - 'TMOUT': '86400', 04:34:21 INFO - 'USER': 'cltbld', 04:34:21 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:21 INFO - '_': '/tools/buildbot/bin/python'} 04:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:21 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:23 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 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 04:34:24 INFO - Downloading docopt-0.6.1.tar.gz 04:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:24 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:24 INFO - Running setup.py install for blobuploader 04:34:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:24 INFO - Running setup.py install for requests 04:34:24 INFO - Running setup.py install for docopt 04:34:24 INFO - Successfully installed blobuploader requests docopt 04:34:24 INFO - Cleaning up... 04:34:25 INFO - Return code: 0 04:34:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:25 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:25 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 04:34:25 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 04:34:25 INFO - Using env: {'DISPLAY': ':0', 04:34:25 INFO - 'HOME': '/home/cltbld', 04:34:25 INFO - 'LANG': 'en_US.UTF-8', 04:34:25 INFO - 'LANGUAGE': 'en_US:en', 04:34:25 INFO - 'LOGNAME': 'cltbld', 04:34:25 INFO - 'MAIL': '/var/mail/cltbld', 04:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:25 INFO - 'MOZ_NO_REMOTE': '1', 04:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:25 INFO - 'NO_EM_RESTART': '1', 04:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:25 INFO - 'PWD': '/builds/slave/test', 04:34:25 INFO - 'SHELL': '/bin/bash', 04:34:25 INFO - 'SHLVL': '1', 04:34:25 INFO - 'TERM': 'linux', 04:34:25 INFO - 'TMOUT': '86400', 04:34:25 INFO - 'USER': 'cltbld', 04:34:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:25 INFO - '_': '/tools/buildbot/bin/python'} 04:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:25 INFO - Running setup.py (path:/tmp/pip-rFlEzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:25 INFO - Running setup.py (path:/tmp/pip-EbiD2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:25 INFO - Running setup.py (path:/tmp/pip-Ljlv24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:25 INFO - Running setup.py (path:/tmp/pip-EJfwsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:25 INFO - Running setup.py (path:/tmp/pip-chDe3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:25 INFO - Running setup.py (path:/tmp/pip-9yIvrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:25 INFO - Running setup.py (path:/tmp/pip-vCbXjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:25 INFO - Running setup.py (path:/tmp/pip-HfAQL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:25 INFO - Running setup.py (path:/tmp/pip-3yzBhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:25 INFO - Running setup.py (path:/tmp/pip-Tk0Eoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:26 INFO - Running setup.py (path:/tmp/pip-ljsqt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:26 INFO - Running setup.py (path:/tmp/pip-lHoee0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:26 INFO - Running setup.py (path:/tmp/pip-afnr2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:26 INFO - Running setup.py (path:/tmp/pip-cnkxtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:26 INFO - Running setup.py (path:/tmp/pip-XW06c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:26 INFO - Running setup.py (path:/tmp/pip-k7i7ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:26 INFO - Running setup.py (path:/tmp/pip-ZojbAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:26 INFO - Running setup.py install for manifestparser 04:34:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:26 INFO - Running setup.py install for mozcrash 04:34:26 INFO - Running setup.py install for mozdebug 04:34:26 INFO - Running setup.py install for mozdevice 04:34:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:26 INFO - Running setup.py install for mozfile 04:34:27 INFO - Running setup.py install for mozhttpd 04:34:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozinfo 04:34:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozInstall 04:34:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozleak 04:34:27 INFO - Running setup.py install for mozlog 04:34:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for moznetwork 04:34:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozprocess 04:34:27 INFO - Running setup.py install for mozprofile 04:34:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozrunner 04:34:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:27 INFO - Running setup.py install for mozscreenshot 04:34:28 INFO - Running setup.py install for moztest 04:34:28 INFO - Running setup.py install for mozversion 04:34:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:28 INFO - Cleaning up... 04:34:28 INFO - Return code: 0 04:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:28 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')]} 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 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')]} 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:28 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 04:34:28 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 04:34:28 INFO - Using env: {'DISPLAY': ':0', 04:34:28 INFO - 'HOME': '/home/cltbld', 04:34:28 INFO - 'LANG': 'en_US.UTF-8', 04:34:28 INFO - 'LANGUAGE': 'en_US:en', 04:34:28 INFO - 'LOGNAME': 'cltbld', 04:34:28 INFO - 'MAIL': '/var/mail/cltbld', 04:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:28 INFO - 'MOZ_NO_REMOTE': '1', 04:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:28 INFO - 'NO_EM_RESTART': '1', 04:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:28 INFO - 'PWD': '/builds/slave/test', 04:34:28 INFO - 'SHELL': '/bin/bash', 04:34:28 INFO - 'SHLVL': '1', 04:34:28 INFO - 'TERM': 'linux', 04:34:28 INFO - 'TMOUT': '86400', 04:34:28 INFO - 'USER': 'cltbld', 04:34:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:28 INFO - '_': '/tools/buildbot/bin/python'} 04:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:28 INFO - Running setup.py (path:/tmp/pip-V2PRV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:28 INFO - Running setup.py (path:/tmp/pip-9iUrbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:28 INFO - Running setup.py (path:/tmp/pip-NVlQRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:28 INFO - Running setup.py (path:/tmp/pip-1J2Va0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:28 INFO - Running setup.py (path:/tmp/pip-MbfZ0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:28 INFO - Running setup.py (path:/tmp/pip-wgisLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:28 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)) 04:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:28 INFO - Running setup.py (path:/tmp/pip-aAPV3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:29 INFO - Running setup.py (path:/tmp/pip-DtrFLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:29 INFO - Running setup.py (path:/tmp/pip-8Dn0kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:29 INFO - Running setup.py (path:/tmp/pip-jXoh5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:29 INFO - Running setup.py (path:/tmp/pip-eI3ERl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:29 INFO - Running setup.py (path:/tmp/pip-weFNfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:29 INFO - Running setup.py (path:/tmp/pip-8teF0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:29 INFO - Running setup.py (path:/tmp/pip-remiPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:29 INFO - Running setup.py (path:/tmp/pip-rN7sDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:29 INFO - Running setup.py (path:/tmp/pip-9yAiab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:29 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)) 04:34:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:29 INFO - Running setup.py (path:/tmp/pip-NTd7_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:29 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)) 04:34:29 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)) 04:34:29 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)) 04:34:29 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)) 04:34:29 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)) 04:34:29 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)) 04:34:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:29 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 04:34:31 INFO - Downloading blessings-1.6.tar.gz 04:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:31 INFO - Installing collected packages: blessings 04:34:31 INFO - Running setup.py install for blessings 04:34:31 INFO - Successfully installed blessings 04:34:31 INFO - Cleaning up... 04:34:31 INFO - Return code: 0 04:34:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:32 INFO - Reading from file tmpfile_stdout 04:34:32 INFO - Current package versions: 04:34:32 INFO - argparse == 1.2.1 04:34:32 INFO - blessings == 1.6 04:34:32 INFO - blobuploader == 1.2.4 04:34:32 INFO - docopt == 0.6.1 04:34:32 INFO - functools32 == 3.2.3-2 04:34:32 INFO - jsonschema == 2.5.1 04:34:32 INFO - manifestparser == 1.1 04:34:32 INFO - mozInstall == 1.12 04:34:32 INFO - mozcrash == 0.17 04:34:32 INFO - mozdebug == 0.1 04:34:32 INFO - mozdevice == 0.48 04:34:32 INFO - mozfile == 1.2 04:34:32 INFO - mozhttpd == 0.7 04:34:32 INFO - mozinfo == 0.9 04:34:32 INFO - mozleak == 0.1 04:34:32 INFO - mozlog == 3.4 04:34:32 INFO - moznetwork == 0.27 04:34:32 INFO - mozprocess == 0.23 04:34:32 INFO - mozprofile == 0.28 04:34:32 INFO - mozrunner == 6.12 04:34:32 INFO - mozscreenshot == 0.1 04:34:32 INFO - mozsystemmonitor == 0.3 04:34:32 INFO - moztest == 0.7 04:34:32 INFO - mozversion == 1.4 04:34:32 INFO - psutil == 3.1.1 04:34:32 INFO - requests == 1.2.3 04:34:32 INFO - wsgiref == 0.1.2 04:34:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:32 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')]} 04:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:32 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')]} 04:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:32 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:32 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 04:34:32 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 04:34:32 INFO - Using env: {'DISPLAY': ':0', 04:34:32 INFO - 'HOME': '/home/cltbld', 04:34:32 INFO - 'LANG': 'en_US.UTF-8', 04:34:32 INFO - 'LANGUAGE': 'en_US:en', 04:34:32 INFO - 'LOGNAME': 'cltbld', 04:34:32 INFO - 'MAIL': '/var/mail/cltbld', 04:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:32 INFO - 'MOZ_NO_REMOTE': '1', 04:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:32 INFO - 'NO_EM_RESTART': '1', 04:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:32 INFO - 'PWD': '/builds/slave/test', 04:34:32 INFO - 'SHELL': '/bin/bash', 04:34:32 INFO - 'SHLVL': '1', 04:34:32 INFO - 'TERM': 'linux', 04:34:32 INFO - 'TMOUT': '86400', 04:34:32 INFO - 'USER': 'cltbld', 04:34:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:32 INFO - '_': '/tools/buildbot/bin/python'} 04:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 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)) 04:34:32 INFO - Cleaning up... 04:34:32 INFO - Return code: 0 04:34:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:32 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')]} 04:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:32 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')]} 04:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:32 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 0x7fb2a1517f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d978a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e64790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', '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 04:34:32 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 04:34:32 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 04:34:32 INFO - Using env: {'DISPLAY': ':0', 04:34:32 INFO - 'HOME': '/home/cltbld', 04:34:32 INFO - 'LANG': 'en_US.UTF-8', 04:34:32 INFO - 'LANGUAGE': 'en_US:en', 04:34:32 INFO - 'LOGNAME': 'cltbld', 04:34:32 INFO - 'MAIL': '/var/mail/cltbld', 04:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:32 INFO - 'MOZ_NO_REMOTE': '1', 04:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:32 INFO - 'NO_EM_RESTART': '1', 04:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:32 INFO - 'PWD': '/builds/slave/test', 04:34:32 INFO - 'SHELL': '/bin/bash', 04:34:32 INFO - 'SHLVL': '1', 04:34:32 INFO - 'TERM': 'linux', 04:34:32 INFO - 'TMOUT': '86400', 04:34:32 INFO - 'USER': 'cltbld', 04:34:32 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:32 INFO - '_': '/tools/buildbot/bin/python'} 04:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:32 INFO - Cleaning up... 04:34:32 INFO - Return code: 0 04:34:32 INFO - Running post-action listener: _resource_record_post_action 04:34:32 INFO - Running post-action listener: _start_resource_monitoring 04:34:32 INFO - Starting resource monitoring. 04:34:32 INFO - [mozharness: 2016-10-06 11:34:32.635097Z] Finished create-virtualenv step (success) 04:34:32 INFO - [mozharness: 2016-10-06 11:34:32.635552Z] Running install step. 04:34:32 INFO - Running pre-action listener: _resource_record_pre_action 04:34:32 INFO - Running main action method: install 04:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:32 INFO - Reading from file tmpfile_stdout 04:34:32 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:32 INFO - Reading from file tmpfile_stdout 04:34:32 INFO - Output received: 04:34:32 INFO - Usage: mozinstall [options] installer 04:34:32 INFO - Options: 04:34:32 INFO - -h, --help show this help message and exit 04:34:32 INFO - -d DEST, --destination=DEST 04:34:32 INFO - Directory to install application into. [default: 04:34:32 INFO - "/builds/slave/test"] 04:34:32 INFO - --app=APP Application being installed. [default: firefox] 04:34:32 INFO - mkdir: /builds/slave/test/build/application 04:34:32 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'] 04:34:32 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 04:34:49 INFO - Reading from file tmpfile_stdout 04:34:49 INFO - Output received: 04:34:49 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - [mozharness: 2016-10-06 11:34:49.942030Z] Finished install step (success) 04:34:49 INFO - [mozharness: 2016-10-06 11:34:49.942277Z] Running run-tests step. 04:34:49 INFO - Running pre-action listener: _resource_record_pre_action 04:34:49 INFO - Running main action method: run_tests 04:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:49 INFO - Python 2.7.3 04:34:49 INFO - Return code: 0 04:34:49 INFO - grabbing minidump binary from tooltool 04:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:49 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 0x1e61930>, '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 0x1e62830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e62cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:49 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 04:34:49 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 04:34:49 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 04:34:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:50 INFO - Return code: 0 04:34:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:50 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:34:50 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 04:34:50 INFO - Using env: {'DISPLAY': ':0', 04:34:50 INFO - 'HOME': '/home/cltbld', 04:34:50 INFO - 'LANG': 'en_US.UTF-8', 04:34:50 INFO - 'LANGUAGE': 'en_US:en', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MAIL': '/var/mail/cltbld', 04:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SHLVL': '1', 04:34:50 INFO - 'TERM': 'linux', 04:34:50 INFO - 'TMOUT': '86400', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - '_': '/tools/buildbot/bin/python'} 04:34:50 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/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 04:34:50 INFO - mozversion application_buildid: 20161006003024 04:34:50 INFO - mozversion application_changeset: 1d7748535fa370332623ac29e50dd19e1ef6133b 04:34:50 INFO - mozversion application_display_name: Nightly 04:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:50 INFO - mozversion application_name: Firefox 04:34:50 INFO - mozversion application_remotingname: firefox 04:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:34:50 INFO - mozversion application_vendor: Mozilla 04:34:50 INFO - mozversion application_version: 52.0a1 04:34:50 INFO - mozversion platform_buildid: 20161006003024 04:34:50 INFO - mozversion platform_changeset: 1d7748535fa370332623ac29e50dd19e1ef6133b 04:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:34:50 INFO - mozversion platform_version: 52.0a1 04:34:50 INFO - using testdate: 1475753690 04:34:50 INFO - actual date: 1475753690 04:34:50 INFO - starting webserver on 'localhost:59363' 04:34:50 INFO - SUITE-START | Running 2 tests 04:34:50 INFO - TEST-START | dromaeo_css 04:34:50 INFO - operating with platform_type : linux_ 04:34:50 INFO - Initialising browser for dromaeo_css test... 04:34:50 INFO - TEST-INFO | started process 4692 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBmsLtI/profile http://localhost:59363/getInfo.html) 04:34:54 INFO - PROCESS | 4692 | __metrics Screen width/height:1600/1200 04:34:54 INFO - PROCESS | 4692 | colorDepth:24 04:34:54 INFO - PROCESS | 4692 | Browser inner width/height: 1024/697 04:34:54 INFO - PROCESS | 4692 | __metrics 04:34:55 INFO - PROCESS | 4692 | 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" 04:34:55 INFO - PROCESS | 4692 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:55 INFO - PROCESS | 4692 | console.error: PushService: 04:34:55 INFO - PROCESS | 4692 | stateChangeProcessEnqueue: Error transitioning state 04:34:55 INFO - PROCESS | 4692 | UnknownError 04:34:56 INFO - TEST-INFO | 4692: exit 0 04:34:56 INFO - Browser initialized. 04:34:56 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:56 INFO - TEST-INFO | started process 4773 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBmsLtI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:08 INFO - PROCESS | 4773 | RSS: Main: 173617152 04:35:08 INFO - PROCESS | 4773 | 04:35:59 INFO - PROCESS | 4773 | 1475753759724 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] 04:38:10 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59363/tests/dromaeo/cssquery-ext.html) 04:38:11 INFO - PROCESS | 4773 | RSS: Main: 318894080 04:38:11 INFO - PROCESS | 4773 | 04:41:14 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-ext.html (next: http://localhost:59363/tests/dromaeo/cssquery-jquery.html) 04:41:15 INFO - PROCESS | 4773 | RSS: Main: 274165760 04:41:15 INFO - PROCESS | 4773 | 04:44:17 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59363/tests/dromaeo/cssquery-mootools.html) 04:44:17 INFO - PROCESS | 4773 | RSS: Main: 247881728 04:44:17 INFO - PROCESS | 4773 | 04:47:19 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59363/tests/dromaeo/cssquery-prototype.html) 04:47:20 INFO - PROCESS | 4773 | RSS: Main: 250527744 04:47:20 INFO - PROCESS | 4773 | 04:50:23 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59363/tests/dromaeo/cssquery-yui.html) 04:50:23 INFO - PROCESS | 4773 | RSS: Main: 217006080 04:50:23 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | Cycle 1(1): loaded http://localhost:59363/tests/dromaeo/cssquery-yui.html (next: http://localhost:59363/tests/dromaeo/cssquery-dojo.html) 04:53:26 INFO - PROCESS | 4773 | RSS: Main: 301592576 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | __start_tp_report 04:53:26 INFO - PROCESS | 4773 | _x_x_mozilla_page_load 04:53:26 INFO - PROCESS | 4773 | _x_x_mozilla_page_load_details 04:53:26 INFO - PROCESS | 4773 | |i|pagename|runs| 04:53:26 INFO - PROCESS | 4773 | |0;dojo.html;2915.2128925190195;2977.8808847646083;2983.6121304230455;2997.6252968378953;3029.136696041627;5030.974845125778;5057.342545469093;5100.591952643785;5199;5201.115810312246;5112.846614601568;5143.614228932826;5183.403908550517;5217.843464696065;5242.554382877451;4708.7645617719145;4712.340272361872;4723.976380118112;4730.195866702652;4850.466448690641;4853.1264372413125;4870.269459581055;4893.681910675812;4917.041176970492;4958.132326842806;4689.366935463703;4749.311349854252;4752.9762351188365;4818.9036219275595;4876.341693871317;4787.904241915142;4797.040591881638;4797.736124513151;4804.975975120137;4807.9038419231765;4755.50067242938;4761.452432970218;4763.595094416979;4772.331873537708;4772.7136371817805;5167.819126330561;5214.400343960455;5217.713025783581;5220.138677118271;5226.8693282667855;5463.48096930791;5534.4742249486235;5542.86142846428;5549.667019978814;5556.6943818089985;5504.559635229172;5514.117741161395;5519.254900588409;5520.861978450531;5556.499915007628;5212.426633070321;5248.317718696545;5255.76349064293;5262.368515778055;5319.388270348882;5490.203920431515;5512.062949298629;5651.378348381675;5675.3757086720425;5696.943030569641;5486.231927530149;5504.2294078829;5507.228987941691;5514.558835293167;5562.3881373048935;5580.609357345028;5592.5246354059545;5594.496495315441;5595.104783234663;5598.468145526169;5312.309399778004;5354.892902141935;5442.12925931849;5469.972650136724;5499.257600223998;5526.47498487643;5583.190437386556;5586.1062230043;5586.441355864381;5589.664620122724;4268.0823622921225;4270.961140115134;4273.1240095780295;4296.119295544406;4322.524522302544;3744.251149770057;3755.0424641716186;3836.3286424875537;3860.0735823402183;3883.2427676602792;5174.586033117342;5277.604179686539;5287.365516138011;5347.171188465794;5348.786048558014;5545.057340252167;5577.776888924479;5585.58108141891;5590.049691552445;5605.831825045255;5272.578193744491;5284.682919024871;5288.418273989858;5297.125974214288;5299.682019078868;4730.574248317599;4770.427548694179;4794.9280760788615;4826.831060912921;4844.176489996709;5730.283714535683;5751.884962300647;5754.079347304495;5754.165645981393;5808.477237048602;5538.944610553843;5540.252065971204;5543.25166102571;5546.057170280981;5569.526590239713;5609.579281553982;5652.491275785199;5664.971675141763;5716.342620598684;5738.5696072795545;5450.236966824568;5454.4545545445135;5457.754401052041;5507.7246137693755;5510.1459273812625;5486.972565137149;5515.310586176728;5533.3083364579425;5533.972330138485;5541.6120871540215;5246.868828279324;5305.442928492607;5409.594280428905;5412.648177868426;5432.239486471976;5449.509544141047;5530.05988981866;5537.058700020925;5579.497845193952;5582;5479.123340265698;5479.369872464558;5480.3971563128825;5482.972585137049;5485.0949593318255;5299.735013249399;5368.812091576776;5446.618736688394;5512.2558454608115;5596.048671725735;5380.112281473513;5446.891062178814;5453.072977593739;5498.5876059296515;5508.03609368367 04:53:26 INFO - PROCESS | 4773 | |1;ext.html;550.7303592577972;586.5483577645214;593.3384276531667;593.5815250248576;613.4478968927964;31340.843295783518;41788.58211417885;42595.36106958398;42736.78631606846;42813.14373712524;43681.34477982833;44194.11611767771;44219.77890110545;44276.3358549622;44287.55712442875;8051.597420128999;8352.079021824984;8906.688265910694;9066.45601263923;9072.047435019327;10505.52725127371;10775.461226938662;10781.892181078167;11177.161712871526;11178.552857885676;10941.070009049241;11040.668779936615;11056.336619802838;11056.391898445583;11058.723531911726;10734.355938643706;10754.731131721692;10795.46022698862;10803.621873234477;10809.405482698448;10652.946735266274;10740.355578665305;10744;10745;10747.677569672922;41833.58166418358;41948.1610367794;42219.7889010553;42264.366034509505;42268.788656056524;2887.5524293734293;3321.983390083058;3352.547406100194;3449.3618680543927;3874.9925019495136;31593.84203078993;31760.682393176005;31823.84088079568;31931.680683193103;33564.328713425835;4184.51878034027;4189.7695626740515;4345.50026746925;4364.803583838735;4410.29435290352;231944;232260;232798;233147;233988;34304.313913721584;56600.43399566034;56792;56895;56974.43025569774;35145;36624.81687591545;36906.44640330397;37146.62853371432;37166.62833371686;15647.139407332706;15798.447054353042;15800.051996880224;15802.288896999433;15816.920915395349;11709.941450292694;11897.940510297392;12711.55509557161;12995.935020324838;12998.415071321813;8499.575021249037;8501.872471912926;8535.189157030072;8637.827243455096;8641.179087986757;3315.784474009182;3346.3140056288403;3388.203772113551;3396;3398.04854640701;1003.2945485672174;1014.2443879309961;1038.5326603028668;1123.1351859068473;1148.3741360958297;31393;31713.412109755143;31715.365692686017;31730.841345793586;31901.52147717786;1045.4929359260752;1092.2136062035322;1098.9999100818218;1115.7154925493946;1168.4333098447246;16118.75821862673;16862.83137168637;16864.91567542179;16901.492955211364;16935.491935241964;485373;488056;488894;489322;490115;56327;56739;56922.146167807514;56929.71535142298;56994.71502642543;1231.4950870143198;1273.6943133647858;1318.413306078805;1364.222393235846;1374.4502199120432;27960.30099247535;31775.841120794248;31896;32009.83995080103;32415.675843241264;48191.5180848187;51868.48131518788;53205;53238.46761532335;58731.706341468016;436345;440640;440744;441204;442769;27166.456670866868;27699.307517312227;27846.44307113887;27929.441411171258;41679;42376.364354535326;42712;42764.57235427606;46253.53746462627;47280;39446.2110757789;39869;40040;40715.79642101771;42239;39056.41415378828;39606.40590391089;40327.1934561313;40658.59341406548;41461.1707765837;39218.215635687695;40164.59835401725;40539;40868.59131408648;40989.79505102456;33092.669073308956;36022;36399;36820.81589592035;37226.6277337234;26478.338041549116;26670.333241668337;26960;27298.317542061606;27465.17604471869 04:53:26 INFO - PROCESS | 4773 | |2;jquery.html;375.59998601489394;392.6073926073926;407.5089517131855;409.30213985155314;425.0415313468131;13491.730165396686;15455.536333909973;18886.244550217976;19114.426567203005;19845.503862403446;18575.25698972043;19065.237390504364;19149.808501914977;19160.83846165381;19696.11367488463;4731.621470282369;5518.586106042053;5951.196588460546;5979.760809567612;5991.221141251631;4286.614204721574;4532.161550113239;5874.9118763218585;5883.617564858292;5912.054071348563;6337.588056776318;6643;6654.567453115532;6695.3304669533145;6744.730210791562;6423.229212494507;6566.080748695163;6600.471962243057;6603.141591593062;6724.159480064992;5653.773849046033;5762.164486149527;5812.709364531756;5834.941650583524;5837;18470.53823654406;18747.81252187488;18753.531161721065;19643.607127857507;22781.658275125887;2261.1746712450004;2475.405902583367;2571;2784.568391899259;2984.179350678559;13948.721025579533;14470.348834302482;14789.556313310617;14888.776668349983;15377.384904603914;1913.2155816115326;1925.0217959895378;1962.519182800209;1963;2054.065400242886;77810.6109469449;80382.59808700977;81123.18876811274;81432.59283703603;83085;10631.84052239217;10821.783564328669;11044.613438529614;11123.777524449466;11176.696971665804;15683.686326273411;15757.606059848365;15759.448419305269;15766.605834853992;15796;7747.2640099190485;7820.960895195488;7906.5651389173;8058.234467725557;8196.385271104691;7481.9251807482315;7603.695852165852;7841.333486653584;7847.1368149503505;7882;4701.741404222732;4762.928556071662;4783.402074740658;4797.880052998633;4876.902461950741;1794.9910250448663;1837.9148382983674;1934.516370907273;1970.881747095179;2049.1496029148034;830.6179157587457;893.5130353957109;973.2262851033446;1013.3261381181579;1036.8548403223404;18984;19519.219231230592;19643.31248406299;19828.20687172526;20023.499412514804;950.538988590533;964.5611246882652;989.248171389749;1011.6914341126027;1038.6676263595577;10507.31702439339;10857.239993200401;10964.725881852857;10977.39624320654;11069.335839849635;417066;449004;457494;459549;459906;88530.55734721414;89567.55216223878;89686.55156724305;90897.54551227202;95119;933.5472295936465;934.6635211323918;954.61815273891;957.3011701457974;1016.755978565139;16486.83513164853;16489.67020659604;17119;17453.825461745728;17754.5561360967;40473.797631012836;40604.59395406008;40803.1839363217;40949.795251023555;41279;56520;57175.42824571701;57460.42539574551;58070;59678.403215967286;8222.218889205516;8389.454685445426;8556.828863422821;8696.478211307342;8788.472691638523;9557.808843823224;11676.70808229801;12565.623031309075;12687.746245075232;13051.934740326238;7790;11155.330680159217;11407.319279969035;11569;11810.704732381415;11077.003069723763;11355.489002995051;11392.658220253406;11682.357470339213;11829.408529573315;11594.072474201876;11620.418979051183;11865.347405892759;11970.084786434129;12302.323372214614;8478.152184781473;11020.724481888017;11500.424978751196;11832.645020649394;11931.76136477283;11260.662180134608;11574.537018519164;11586.42067896585;11829.17195796286;12238 04:53:26 INFO - PROCESS | 4773 | |3;mootools.html;1441.4378392426952;1482.1033274868705;1610.798650168729;1731.3161301285984;1783.5897743518983;7932.405069619787;8245.134260902609;8326.167383261678;9038.954805225965;9048.502332371725;8406.705765298217;8693.69572064978;8740.344474164447;8960.820783584324;8974.596143173556;2305.0549274797295;2326.9883650581723;2343.0979073056824;2347.882605869708;2350.9177178798745;1980.6434841728483;2280.623697089978;2301.7698230176934;2319.3158018384615;2354.8233882458885;2016.969745453812;2253.5605556916407;2317.4206448387904;2319.489712263308;2327.592671282519;2229.7881701238357;2236.608593496148;2249.111600917645;2250.8086812620945;2307.0541078157876;2255.819534437241;2259.186692790594;2263.7283525976823;2264.230161745015;2266.841321107523;8816.426932249384;8844.73465796027;8889.911100888972;8898.37711360205;8904.643814247422;4974.179260422026;5122.667026643294;5178.145605975047;5181.481851814826;5192.740362981874;3179.1098492422157;3184.4268031754277;3184.4268031754277;3238.8542515586855;3260.96739032609;1129.2772625519674;1129.9378534180616;1138.6128716236437;1142.0749193153572;1160.628598848369;12164.452599633038;12191.19602491432;12199;12203.145779795417;12208.511659533608;4245.490541135022;4403.779811009501;4514.841980530666;4561.2473941799235;4591.747453890068;10272.435016074187;10273.794524109626;10274.126699230499;10280.691579252634;10288.794224115625;5138.100832354323;5138.87152821175;5140.280360749423;5142.074426603247;5145.07388670043;4677.111348843709;4711.45818230901;4741.5021422750115;4747.667663263607;4772.427308722906;3728.4780130781714;3802.7147963902266;3826.464294998647;3831.885043448701;3905.5703872573995;1078.1267173589417;1119.5353928119903;1212.3271584270638;1234.8765123487578;1254.347739175642;871.808202195516;918.4672889723944;922.5064590444081;945.6926498887889;951.1202138022302;5668.093105103164;5974.9402505974385;5988.820335389945;6030.728617212236;6399.328070552618;834.9582520873932;915.5925613102106;944.6646440513656;947.7346343023964;962.3985009369144;4069.2268468991388;4093.181363727207;4099.795010249476;4125.422440858282;4263.957360426356;10524.421156836295;10890.564377424815;10929.344239345664;10999.945000274947;11001.449927503592;10847.40339281347;10857.51141198648;10860.076893463985;10879;10904.890951090387;7632.93138960546;7806.843863122705;7931.325837303893;7934.960325198453;7969.521828690297;5778.508826749605;5813.941860581509;5851.444112809277;5853.063509838576;6069.089636554552;10030.147437467605;10050.145737612092;10073.597056117966;10117.342372745748;10185.9490702546;10033.548490317808;10257.538410771682;10516.894831051592;10519;10527.31572447819;7278.67245973943;7332.376747976482;7381.711669382508;7382.298681625237;7385.187629360874;7849.979502664617;8112.634931427981;8164.877526837221;8170.01959764832;8179.591020448835;7560.6219689016425;7726.072871255486;7826.647800848861;7914.327282181079;7938.3252423542335;7535.712162938445;7605.543667379975;7639.312461878458;7795.22047795216;7825.726099586487;6792.524523283323;6838.14523184602;6917.100776898971;6942.201646810681;6993.055937448583;5095.108356037605;5206.55744261742;5264.31563896691;5314.920276195783;5427.294451721251;5164.948350516447;5180.766865491138;5242.97378513105;5272.78908843642;5287.920681189862 04:53:26 INFO - PROCESS | 4773 | |4;prototype.html;326.8970274363575;331.61863856564946;336.966303369663;340.5334691472683;345.70096866210736;5381.838544843651;5441.972790136054;5479.506844384;5483.1501117326825;5493.670379777216;5114.488551144884;5118.257852611369;5208.947910520894;5223.164293713006;5261.263423120766;4201.70588058836;4204.453421055258;4210.3894935234375;4217.40956266123;4234.17433600448;4225.323948168294;4225.936610950838;4240.173166232586;4241.363795430695;4251.4898212214575;3894.415837624365;3894.9805250973704;4126.5667104954;4145.440365550642;4165.458490396244;4127.40152677863;4134.627883490485;4144.274751918432;4153.397757325201;4153.460050193456;3698.445233215012;3712.7772333659796;3717.3494638438438;3718.665320121202;3719.758215715997;5163.5352818246165;5194.63637545372;5205.27126202332;5212.0128102002;5276.419593844674;4818.7831547580445;4828.758562071883;4829.058333624945;4836.960053588496;4865.270209468573;5587.106063029895;5595;5639.6334238274385;5641.746121424505;5666.376698563155;4051.2728289973297;4077.5106987161435;4108.5275193352845;4112.177564487085;4145.17096580685;5757.4818266355815;5765.884682306372;5787.421257874221;5792.507636850873;5799.246098007275;4222.619964203236;4245.235857545671;4247.8088486018205;4256.063665993476;4270.252705776476;4198.811053502539;4222.1766755483;4258.488981322199;4267.701260911706;4319.503257125471;4810.975945120252;4814.470408255089;4817.9036419271415;4840.201366774513;4841.878953026132;5581.6371935824045;5596.38439771633;5606.635568688022;5618.831435056954;5669.971650141723;1388.8472567768729;1423.181670539444;1460.1531111955253;1463.6487243061588;1472.337448148316;956.4834989105805;1016.4358780876685;1045.895410458948;1048.9108425783893;1057.6562617149457;5437.640589852537;5491.423400542885;5495.560355171577;5506.889862202734;5512.80705175325;5548.4174161713245;5756.222909907193;5756.740946657411;5775.682337471395;5825.737841797045;5424.620276580601;5433.864153396117;5435.565154787608;5439.428859969726;5469.699166545878;3048.1008102609785;3066.7853250272715;3067.3405217877817;3068.3403068340413;3082.1370016395445;5731.312242530839;5978.103284507271;5982.222311099529;5998;6002.879942401128;5842.912356314659;5852.912206316909;5915.822525324247;5928.970355148197;5929.495992840657;5739.741711623071;5945.581290757832;5946.316173640001;5971.19388882504;5996.5202783777195;5765.91351129725;5776.855578610568;5779.190913272229;5782.5663075268685;5784.190213370048;5642.6614403135945;5714.342850572071;5722.484976352148;5805.287440205065;5823.155642431909;5888.3228428731245;5930.229070220844;5938.703064846654;5951.672658003851;6088.169001414363;4180.435641188401;4195.643370313557;4202.726822756511;4220.95779042218;4221.240176768211;5865.530757539472;5865.794697185578;5871.588988770745;5872.265966754156;5877.471027607536;5496.725163741717;5659.490645841894;5667.3765885753355;5701;5716.971415142898;5617.943820561742;5632.633878797865;5646.774129034957;5670.603057785916;5676.772929082956;5284.656497327662;5343.866403339947;5564.4991950724625;5677.261955945701;5686.545076393796;5623.493885550321;5626.35296940857;5633.4084921082695;5644.209810626598;5644.6613203207935;5396.487333703292;5399.433059528693;5468.699221542854;5500.697461639648;5513.751881165437 04:53:26 INFO - PROCESS | 4773 | |5;yui.html;754.5359603843634;759.6239861268671;785.399169635229;823.991760082399;839.8488272111017;15261.771073433907;16697.91651041743;16718.832811671895;16721.247543860525;16734.414295499646;14300.14199148052;14321.355539000744;14359.712805743879;14367.78448323276;14390.352434140463;767.4321002458197;784.4077721320396;784.8469548438056;785.2226295967008;785.45018487059;646.079336944854;663.8074958262098;778.381186956371;791.5804623549499;794.5510786405691;847.6270441005969;853.1638993786094;854.9615267312955;856.7900864288258;861.6854847980504;838.1953324808192;850.0437008365589;852.7100785732849;852.9530875801828;853.2917678326974;624.3912185619031;625.399616368287;625.4808508937571;625.5464788028688;625.6308777821107;10347.94826025865;10804.405757683324;14380.209088500129;14786.556403307917;14795.186264755434;14326.856731432761;15087.4719384821;15317.846821531864;15363.4622788203;15629.687406251925;11731.354775487345;11861.169718119734;12011.279323240633;12027.304909805125;12059;3816.084139806454;3826.6747326477284;3835.654791068789;3875.399313106473;3907.765534067965;76419.6179019107;76544.23455765427;76564.34356564355;77217;77275;11245.887541124484;11321.150913681508;11573;11697.12271579635;11756.94121529387;21174.364769056952;21202.15191392327;21217.893910530347;21220.151193952377;21228.78771212299;8169.856697076227;8488.787780305542;8490.745277641681;8565.48607083577;8666.263367613823;4583.449986001701;4626.930596041062;4698.271767875985;4772.761361931959;4863.80544778212;3291.8189499577275;3400.0309911675054;3402.0644322811427;3405.965940340565;3407.931841363159;568.6190252530814;568.8236646639555;569.4248808703239;572.4504475703288;594.9910751338733;527.6965744696814;723.6924307169432;761.0638914135644;763.7785042337771;788.8461749958703;8617.61220745068;8689.348298877609;8809;8922.02212541729;9320.161185493338;623.4856243599049;644.3041515163612;658.7463826426861;683.6684208159039;712.4620911212002;4175.62419382257;4341.60925516705;4482.574155455227;4488.281874900001;4493.236149854532;71802.28197717956;72257;80334.59832700799;127198.36400818122;127582.36208818897;62408.37591624026;63450.682746585975;65224;108604;108705.45647271712;54655.18017229824;74153.25846741571;87544.5622771882;88527;94011.52994234985;8559.657613695383;8742.169493898069;8882;9035.593398297224;9272.594629200563;51197.488025120765;51519;52086;54154.187687183934;54761.45238547723;70234.64882675554;76233;78947.60526197332;79469.60265198637;80490.59754701423;11147.777044458902;11593.536258549564;11717;11836.408179590813;11908.40457977115;13036;13432.462701491831;13449.46202151903;13684.931575342458;14173.503927362493;12186.390680466118;12363.505459781509;12597.811032834697;12681.340794306223;12982.15615984958;12310.446029928495;12378.690532736753;12386.132970691964;12505.124641275024;12590.307533085403;11628.302301861915;11656.650300491;11997;12386.876131238932;12395.194312369667;10079.596816127272;10172.542235599563;10313;10472.633457828939;10500.894991049992;9849.704508864745;10081.092701656886;10164.960747292178;10201.591936322464;10264.948675256575 04:53:26 INFO - PROCESS | 4773 | __end_tp_report 04:53:26 INFO - PROCESS | 4773 | __start_cc_report 04:53:26 INFO - PROCESS | 4773 | _x_x_mozilla_cycle_collect,1229 04:53:26 INFO - PROCESS | 4773 | __end_cc_report 04:53:26 INFO - PROCESS | 4773 | __startTimestamp1475754806776__endTimestamp 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | ------- Summary: start ------- 04:53:26 INFO - PROCESS | 4773 | Number of tests: 6 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#0] dojo.html Cycles:165 Average:5175.82 Median:5409.59 stddev:576.21 (10.7%) stddev-sans-first:550.01 04:53:26 INFO - PROCESS | 4773 | Values: 2915.2 2977.9 2983.6 2997.6 3029.1 5031.0 5057.3 5100.6 5199.0 5201.1 5112.8 5143.6 5183.4 5217.8 5242.6 4708.8 4712.3 4724.0 4730.2 4850.5 4853.1 4870.3 4893.7 4917.0 4958.1 4689.4 4749.3 4753.0 4818.9 4876.3 4787.9 4797.0 4797.7 4805.0 4807.9 4755.5 4761.5 4763.6 4772.3 4772.7 5167.8 5214.4 5217.7 5220.1 5226.9 5463.5 5534.5 5542.9 5549.7 5556.7 5504.6 5514.1 5519.3 5520.9 5556.5 5212.4 5248.3 5255.8 5262.4 5319.4 5490.2 5512.1 5651.4 5675.4 5696.9 5486.2 5504.2 5507.2 5514.6 5562.4 5580.6 5592.5 5594.5 5595.1 5598.5 5312.3 5354.9 5442.1 5470.0 5499.3 5526.5 5583.2 5586.1 5586.4 5589.7 4268.1 4271.0 4273.1 4296.1 4322.5 3744.3 3755.0 3836.3 3860.1 3883.2 5174.6 5277.6 5287.4 5347.2 5348.8 5545.1 5577.8 5585.6 5590.0 5605.8 5272.6 5284.7 5288.4 5297.1 5299.7 4730.6 4770.4 4794.9 4826.8 4844.2 5730.3 5751.9 5754.1 5754.2 5808.5 5538.9 5540.3 5543.3 5546.1 5569.5 5609.6 5652.5 5665.0 5716.3 5738.6 5450.2 5454.5 5457.8 5507.7 5510.1 5487.0 5515.3 5533.3 5534.0 5541.6 5246.9 5305.4 5409.6 5412.6 5432.2 5449.5 5530.1 5537.1 5579.5 5582.0 5479.1 5479.4 5480.4 5483.0 5485.1 5299.7 5368.8 5446.6 5512.3 5596.0 5380.1 5446.9 5453.1 5498.6 5508.0 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#1] ext.html Cycles:180 Average:54478.32 Median:19297.18 stddev:106954.17 (554.2%) stddev-sans-first:107177.57 04:53:26 INFO - PROCESS | 4773 | Values: 550.7 586.5 593.3 593.6 613.4 31340.8 41788.6 42595.4 42736.8 42813.1 43681.3 44194.1 44219.8 44276.3 44287.6 8051.6 8352.1 8906.7 9066.5 9072.0 10505.5 10775.5 10781.9 11177.2 11178.6 10941.1 11040.7 11056.3 11056.4 11058.7 10734.4 10754.7 10795.5 10803.6 10809.4 10652.9 10740.4 10744.0 10745.0 10747.7 41833.6 41948.2 42219.8 42264.4 42268.8 2887.6 3322.0 3352.5 3449.4 3875.0 31593.8 31760.7 31823.8 31931.7 33564.3 4184.5 4189.8 4345.5 4364.8 4410.3 231944.0 232260.0 232798.0 233147.0 233988.0 34304.3 56600.4 56792.0 56895.0 56974.4 35145.0 36624.8 36906.4 37146.6 37166.6 15647.1 15798.4 15800.1 15802.3 15816.9 11709.9 11897.9 12711.6 12995.9 12998.4 8499.6 8501.9 8535.2 8637.8 8641.2 3315.8 3346.3 3388.2 3396.0 3398.0 1003.3 1014.2 1038.5 1123.1 1148.4 31393.0 31713.4 31715.4 31730.8 31901.5 1045.5 1092.2 1099.0 1115.7 1168.4 16118.8 16862.8 16864.9 16901.5 16935.5 485373.0 488056.0 488894.0 489322.0 490115.0 56327.0 56739.0 56922.1 56929.7 56994.7 1231.5 1273.7 1318.4 1364.2 1374.5 27960.3 31775.8 31896.0 32009.8 32415.7 48191.5 51868.5 53205.0 53238.5 58731.7 436345.0 440640.0 440744.0 441204.0 442769.0 27166.5 27699.3 27846.4 27929.4 41679.0 42376.4 42712.0 42764.6 46253.5 47280.0 39446.2 39869.0 40040.0 40715.8 42239.0 39056.4 39606.4 40327.2 40658.6 41461.2 39218.2 40164.6 40539.0 40868.6 40989.8 33092.7 36022.0 36399.0 36820.8 37226.6 26478.3 26670.3 26960.0 27298.3 27465.2 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#2] jquery.html Cycles:180 Average:27810.79 Median:2884.37 stddev:74198.16 (2572.4%) stddev-sans-first:74377.71 04:53:26 INFO - PROCESS | 4773 | Values: 375.6 392.6 407.5 409.3 425.0 13491.7 15455.5 18886.2 19114.4 19845.5 18575.3 19065.2 19149.8 19160.8 19696.1 4731.6 5518.6 5951.2 5979.8 5991.2 4286.6 4532.2 5874.9 5883.6 5912.1 6337.6 6643.0 6654.6 6695.3 6744.7 6423.2 6566.1 6600.5 6603.1 6724.2 5653.8 5762.2 5812.7 5834.9 5837.0 18470.5 18747.8 18753.5 19643.6 22781.7 2261.2 2475.4 2571.0 2784.6 2984.2 13948.7 14470.3 14789.6 14888.8 15377.4 1913.2 1925.0 1962.5 1963.0 2054.1 77810.6 80382.6 81123.2 81432.6 83085.0 10631.8 10821.8 11044.6 11123.8 11176.7 15683.7 15757.6 15759.4 15766.6 15796.0 7747.3 7821.0 7906.6 8058.2 8196.4 7481.9 7603.7 7841.3 7847.1 7882.0 4701.7 4762.9 4783.4 4797.9 4876.9 1795.0 1837.9 1934.5 1970.9 2049.1 830.6 893.5 973.2 1013.3 1036.9 18984.0 19519.2 19643.3 19828.2 20023.5 950.5 964.6 989.2 1011.7 1038.7 10507.3 10857.2 10964.7 10977.4 11069.3 417066.0 449004.0 457494.0 459549.0 459906.0 88530.6 89567.6 89686.6 90897.5 95119.0 933.5 934.7 954.6 957.3 1016.8 16486.8 16489.7 17119.0 17453.8 17754.6 40473.8 40604.6 40803.2 40949.8 41279.0 56520.0 57175.4 57460.4 58070.0 59678.4 8222.2 8389.5 8556.8 8696.5 8788.5 9557.8 11676.7 12565.6 12687.7 13051.9 7790.0 11155.3 11407.3 11569.0 11810.7 11077.0 11355.5 11392.7 11682.4 11829.4 11594.1 11620.4 11865.3 11970.1 12302.3 8478.2 11020.7 11500.4 11832.6 11931.8 11260.7 11574.5 11586.4 11829.2 12238.0 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#3] mootools.html Cycles:180 Average:5739.12 Median:4694.28 stddev:3286.53 (70.0%) stddev-sans-first:3279.88 04:53:26 INFO - PROCESS | 4773 | Values: 1441.4 1482.1 1610.8 1731.3 1783.6 7932.4 8245.1 8326.2 9039.0 9048.5 8406.7 8693.7 8740.3 8960.8 8974.6 2305.1 2327.0 2343.1 2347.9 2350.9 1980.6 2280.6 2301.8 2319.3 2354.8 2017.0 2253.6 2317.4 2319.5 2327.6 2229.8 2236.6 2249.1 2250.8 2307.1 2255.8 2259.2 2263.7 2264.2 2266.8 8816.4 8844.7 8889.9 8898.4 8904.6 4974.2 5122.7 5178.1 5181.5 5192.7 3179.1 3184.4 3184.4 3238.9 3261.0 1129.3 1129.9 1138.6 1142.1 1160.6 12164.5 12191.2 12199.0 12203.1 12208.5 4245.5 4403.8 4514.8 4561.2 4591.7 10272.4 10273.8 10274.1 10280.7 10288.8 5138.1 5138.9 5140.3 5142.1 5145.1 4677.1 4711.5 4741.5 4747.7 4772.4 3728.5 3802.7 3826.5 3831.9 3905.6 1078.1 1119.5 1212.3 1234.9 1254.3 871.8 918.5 922.5 945.7 951.1 5668.1 5974.9 5988.8 6030.7 6399.3 835.0 915.6 944.7 947.7 962.4 4069.2 4093.2 4099.8 4125.4 4264.0 10524.4 10890.6 10929.3 10999.9 11001.4 10847.4 10857.5 10860.1 10879.0 10904.9 7632.9 7806.8 7931.3 7935.0 7969.5 5778.5 5813.9 5851.4 5853.1 6069.1 10030.1 10050.1 10073.6 10117.3 10185.9 10033.5 10257.5 10516.9 10519.0 10527.3 7278.7 7332.4 7381.7 7382.3 7385.2 7850.0 8112.6 8164.9 8170.0 8179.6 7560.6 7726.1 7826.6 7914.3 7938.3 7535.7 7605.5 7639.3 7795.2 7825.7 6792.5 6838.1 6917.1 6942.2 6993.1 5095.1 5206.6 5264.3 5314.9 5427.3 5164.9 5180.8 5243.0 5272.8 5287.9 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#4] prototype.html Cycles:180 Average:4756.18 Median:5434.71 stddev:1385.81 (25.5%) stddev-sans-first:1349.23 04:53:26 INFO - PROCESS | 4773 | Values: 326.9 331.6 337.0 340.5 345.7 5381.8 5442.0 5479.5 5483.2 5493.7 5114.5 5118.3 5208.9 5223.2 5261.3 4201.7 4204.5 4210.4 4217.4 4234.2 4225.3 4225.9 4240.2 4241.4 4251.5 3894.4 3895.0 4126.6 4145.4 4165.5 4127.4 4134.6 4144.3 4153.4 4153.5 3698.4 3712.8 3717.3 3718.7 3719.8 5163.5 5194.6 5205.3 5212.0 5276.4 4818.8 4828.8 4829.1 4837.0 4865.3 5587.1 5595.0 5639.6 5641.7 5666.4 4051.3 4077.5 4108.5 4112.2 4145.2 5757.5 5765.9 5787.4 5792.5 5799.2 4222.6 4245.2 4247.8 4256.1 4270.3 4198.8 4222.2 4258.5 4267.7 4319.5 4811.0 4814.5 4817.9 4840.2 4841.9 5581.6 5596.4 5606.6 5618.8 5670.0 1388.8 1423.2 1460.2 1463.6 1472.3 956.5 1016.4 1045.9 1048.9 1057.7 5437.6 5491.4 5495.6 5506.9 5512.8 5548.4 5756.2 5756.7 5775.7 5825.7 5424.6 5433.9 5435.6 5439.4 5469.7 3048.1 3066.8 3067.3 3068.3 3082.1 5731.3 5978.1 5982.2 5998.0 6002.9 5842.9 5852.9 5915.8 5929.0 5929.5 5739.7 5945.6 5946.3 5971.2 5996.5 5765.9 5776.9 5779.2 5782.6 5784.2 5642.7 5714.3 5722.5 5805.3 5823.2 5888.3 5930.2 5938.7 5951.7 6088.2 4180.4 4195.6 4202.7 4221.0 4221.2 5865.5 5865.8 5871.6 5872.3 5877.5 5496.7 5659.5 5667.4 5701.0 5717.0 5617.9 5632.6 5646.8 5670.6 5676.8 5284.7 5343.9 5564.5 5677.3 5686.5 5623.5 5626.4 5633.4 5644.2 5644.7 5396.5 5399.4 5468.7 5500.7 5513.8 04:53:26 INFO - PROCESS | 4773 | 04:53:26 INFO - PROCESS | 4773 | [#5] yui.html Cycles:180 Average:19425.68 Median:4735.52 stddev:27727.71 (585.5%) stddev-sans-first:27770.05 04:53:26 INFO - PROCESS | 4773 | Values: 754.5 759.6 785.4 824.0 839.8 15261.8 16697.9 16718.8 16721.2 16734.4 14300.1 14321.4 14359.7 14367.8 14390.4 767.4 784.4 784.8 785.2 785.5 646.1 663.8 778.4 791.6 794.6 847.6 853.2 855.0 856.8 861.7 838.2 850.0 852.7 853.0 853.3 624.4 625.4 625.5 625.5 625.6 10347.9 10804.4 14380.2 14786.6 14795.2 14326.9 15087.5 15317.8 15363.5 15629.7 11731.4 11861.2 12011.3 12027.3 12059.0 3816.1 3826.7 3835.7 3875.4 3907.8 76419.6 76544.2 76564.3 77217.0 77275.0 11245.9 11321.2 11573.0 11697.1 11756.9 21174.4 21202.2 21217.9 21220.2 21228.8 8169.9 8488.8 8490.7 8565.5 8666.3 4583.4 4626.9 4698.3 4772.8 4863.8 3291.8 3400.0 3402.1 3406.0 3407.9 568.6 568.8 569.4 572.5 595.0 527.7 723.7 761.1 763.8 788.8 8617.6 8689.3 8809.0 8922.0 9320.2 623.5 644.3 658.7 683.7 712.5 4175.6 4341.6 4482.6 4488.3 4493.2 71802.3 72257.0 80334.6 127198.4 127582.4 62408.4 63450.7 65224.0 108604.0 108705.5 54655.2 74153.3 87544.6 88527.0 94011.5 8559.7 8742.2 8882.0 9035.6 9272.6 51197.5 51519.0 52086.0 54154.2 54761.5 70234.6 76233.0 78947.6 79469.6 80490.6 11147.8 11593.5 11717.0 11836.4 11908.4 13036.0 13432.5 13449.5 13684.9 14173.5 12186.4 12363.5 12597.8 12681.3 12982.2 12310.4 12378.7 12386.1 12505.1 12590.3 11628.3 11656.7 11997.0 12386.9 12395.2 10079.6 10172.5 10313.0 10472.6 10500.9 9849.7 10081.1 10165.0 10201.6 10264.9 04:53:26 INFO - PROCESS | 4773 | -------- Summary: end -------- 04:53:26 INFO - PROCESS | 4773 | 04:53:27 INFO - TEST-INFO | 4773: exit 0 04:53:27 INFO - TEST-OK | dromaeo_css | took 1117512ms 04:53:27 INFO - TEST-START | kraken 04:53:27 INFO - operating with platform_type : linux_ 04:53:27 INFO - Initialising browser for kraken test... 04:53:27 INFO - TEST-INFO | started process 5081 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEhUlz/profile http://localhost:59363/getInfo.html) 04:53:32 INFO - PROCESS | 5081 | __metrics Screen width/height:1600/1200 04:53:32 INFO - PROCESS | 5081 | colorDepth:24 04:53:32 INFO - PROCESS | 5081 | Browser inner width/height: 1024/697 04:53:32 INFO - PROCESS | 5081 | __metrics 04:53:32 INFO - PROCESS | 5081 | 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" 04:53:32 INFO - PROCESS | 5081 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:33 INFO - PROCESS | 5081 | console.error: PushService: 04:53:33 INFO - PROCESS | 5081 | stateChangeProcessEnqueue: Error transitioning state 04:53:33 INFO - PROCESS | 5081 | UnknownError 04:53:34 INFO - TEST-INFO | 5081: exit 0 04:53:34 INFO - Browser initialized. 04:53:34 INFO - Running cycle 1/1 for kraken test... 04:53:34 INFO - TEST-INFO | started process 5161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZEhUlz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:46 INFO - PROCESS | 5161 | RSS: Main: 173797376 04:53:46 INFO - PROCESS | 5161 | 04:53:48 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59363/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:49 INFO - PROCESS | 5161 | RSS: Main: 232812544 04:53:49 INFO - PROCESS | 5161 | 04:53:52 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59363/tests/kraken/driver.html?testName=audio-dft) 04:53:52 INFO - PROCESS | 5161 | RSS: Main: 217526272 04:53:52 INFO - PROCESS | 5161 | 04:53:56 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59363/tests/kraken/driver.html?testName=audio-fft) 04:53:56 INFO - PROCESS | 5161 | RSS: Main: 299196416 04:53:56 INFO - PROCESS | 5161 | 04:53:58 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59363/tests/kraken/driver.html?testName=audio-oscillator) 04:53:59 INFO - PROCESS | 5161 | RSS: Main: 208490496 04:53:59 INFO - PROCESS | 5161 | 04:54:01 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59363/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:02 INFO - PROCESS | 5161 | RSS: Main: 213352448 04:54:02 INFO - PROCESS | 5161 | 04:54:05 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59363/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:05 INFO - PROCESS | 5161 | RSS: Main: 249438208 04:54:05 INFO - PROCESS | 5161 | 04:54:09 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59363/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:09 INFO - PROCESS | 5161 | RSS: Main: 248504320 04:54:09 INFO - PROCESS | 5161 | 04:54:12 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59363/tests/kraken/driver.html?testName=json-parse-financial) 04:54:13 INFO - PROCESS | 5161 | RSS: Main: 248668160 04:54:13 INFO - PROCESS | 5161 | 04:54:14 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59363/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:15 INFO - PROCESS | 5161 | RSS: Main: 210661376 04:54:15 INFO - PROCESS | 5161 | 04:54:16 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:17 INFO - PROCESS | 5161 | RSS: Main: 217960448 04:54:17 INFO - PROCESS | 5161 | 04:54:19 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:20 INFO - PROCESS | 5161 | RSS: Main: 227491840 04:54:20 INFO - PROCESS | 5161 | 04:54:22 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:23 INFO - PROCESS | 5161 | RSS: Main: 235352064 04:54:23 INFO - PROCESS | 5161 | 04:54:26 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:26 INFO - PROCESS | 5161 | RSS: Main: 233054208 04:54:26 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | Cycle 1(1): loaded http://localhost:59363/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59363/tests/kraken/driver.html?testName=ai-astar) 04:54:28 INFO - PROCESS | 5161 | RSS: Main: 284704768 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | __start_tp_report 04:54:28 INFO - PROCESS | 5161 | _x_x_mozilla_page_load 04:54:28 INFO - PROCESS | 5161 | _x_x_mozilla_page_load_details 04:54:28 INFO - PROCESS | 5161 | |i|pagename|runs| 04:54:28 INFO - PROCESS | 5161 | |0;ai-astar;109;112;111;111;112;111;113;113;111;114 04:54:28 INFO - PROCESS | 5161 | |1;audio-beat-detection;145;129;123;165;125;127;122;121;160;127 04:54:28 INFO - PROCESS | 5161 | |2;audio-dft;161;161;159;160;160;162;163;160;161;162 04:54:28 INFO - PROCESS | 5161 | |3;audio-fft;76;76;77;111;77;77;76;76;98;75 04:54:28 INFO - PROCESS | 5161 | |4;audio-oscillator;83;82;111;81;82;81;101;82;81;112 04:54:28 INFO - PROCESS | 5161 | |5;imaging-gaussian-blur;118;118;118;118;117;117;117;117;117;117 04:54:28 INFO - PROCESS | 5161 | |6;imaging-darkroom;146;146;146;145;147;147;145;146;146;146 04:54:28 INFO - PROCESS | 5161 | |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;95 04:54:28 INFO - PROCESS | 5161 | |8;json-parse-financial;51;51;50;50;52;52;51;52;51;52 04:54:28 INFO - PROCESS | 5161 | |9;json-stringify-tinderbox;60;59;60;60;59;59;60;60;60;60 04:54:28 INFO - PROCESS | 5161 | |10;stanford-crypto-aes;80;79;85;79;80;80;83;79;80;80 04:54:28 INFO - PROCESS | 5161 | |11;stanford-crypto-ccm;134;134;130;138;131;133;140;128;164;129 04:54:28 INFO - PROCESS | 5161 | |12;stanford-crypto-pbkdf2;172;165;165;174;169;167;165;164;170;169 04:54:28 INFO - PROCESS | 5161 | |13;stanford-crypto-sha256-iterative;68;68;66;65;66;66;76;68;64;65 04:54:28 INFO - PROCESS | 5161 | __end_tp_report 04:54:28 INFO - PROCESS | 5161 | __start_cc_report 04:54:28 INFO - PROCESS | 5161 | _x_x_mozilla_cycle_collect,1659 04:54:28 INFO - PROCESS | 5161 | __end_cc_report 04:54:28 INFO - PROCESS | 5161 | __startTimestamp1475754868833__endTimestamp 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | ------- Summary: start ------- 04:54:28 INFO - PROCESS | 5161 | Number of tests: 14 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:1.42 (1.3%) stddev-sans-first:1.12 04:54:28 INFO - PROCESS | 5161 | Values: 109.0 112.0 111.0 111.0 112.0 111.0 113.0 113.0 111.0 114.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:128.00 stddev:16.31 (12.7%) stddev-sans-first:16.84 04:54:28 INFO - PROCESS | 5161 | Values: 145.0 129.0 123.0 165.0 125.0 127.0 122.0 121.0 160.0 127.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 04:54:28 INFO - PROCESS | 5161 | Values: 161.0 161.0 159.0 160.0 160.0 162.0 163.0 160.0 161.0 162.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.50 stddev:12.31 (16.1%) stddev-sans-first:12.88 04:54:28 INFO - PROCESS | 5161 | Values: 76.0 76.0 77.0 111.0 77.0 77.0 76.0 76.0 98.0 75.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:81.50 stddev:13.03 (16.0%) stddev-sans-first:13.60 04:54:28 INFO - PROCESS | 5161 | Values: 83.0 82.0 111.0 81.0 82.0 81.0 101.0 82.0 81.0 112.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:54:28 INFO - PROCESS | 5161 | Values: 118.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:54:28 INFO - PROCESS | 5161 | Values: 146.0 146.0 146.0 145.0 147.0 147.0 145.0 146.0 146.0 146.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:54:28 INFO - PROCESS | 5161 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.50 stddev:0.79 (1.5%) stddev-sans-first:0.83 04:54:28 INFO - PROCESS | 5161 | Values: 51.0 51.0 50.0 50.0 52.0 52.0 51.0 52.0 51.0 52.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#9] json-stringify-tinderbox Cycles:10 Average:59.70 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:54:28 INFO - PROCESS | 5161 | Values: 60.0 59.0 60.0 60.0 59.0 59.0 60.0 60.0 60.0 60.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:1.96 (2.4%) stddev-sans-first:2.07 04:54:28 INFO - PROCESS | 5161 | Values: 80.0 79.0 85.0 79.0 80.0 80.0 83.0 79.0 80.0 80.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:134.00 stddev:10.51 (7.8%) stddev-sans-first:11.12 04:54:28 INFO - PROCESS | 5161 | Values: 134.0 134.0 130.0 138.0 131.0 133.0 140.0 128.0 164.0 129.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.00 stddev:3.37 (2.0%) stddev-sans-first:3.24 04:54:28 INFO - PROCESS | 5161 | Values: 172.0 165.0 165.0 174.0 169.0 167.0 165.0 164.0 170.0 169.0 04:54:28 INFO - PROCESS | 5161 | 04:54:28 INFO - PROCESS | 5161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:3.39 (5.1%) stddev-sans-first:3.59 04:54:28 INFO - PROCESS | 5161 | Values: 68.0 68.0 66.0 65.0 66.0 66.0 76.0 68.0 64.0 65.0 04:54:28 INFO - PROCESS | 5161 | -------- Summary: end -------- 04:54:28 INFO - PROCESS | 5161 | 04:54:30 INFO - TEST-INFO | 5161: exit 0 04:54:30 INFO - TEST-OK | kraken | took 62350ms 04:54:30 INFO - SUITE-END | took 1179s 04:54:30 INFO - Completed test suite (00:19:40) 04:54:30 INFO - javascript benchmark 04:54:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2915.2128925190195, 2977.8808847646083, 2983.6121304230455, 2997.6252968378953, 3029.136696041627, 5030.974845125778, 5057.342545469093, 5100.591952643785, 5199.0, 5201.115810312246, 5112.846614601568, 5143.614228932826, 5183.403908550517, 5217.843464696065, 5242.554382877451, 4708.7645617719145, 4712.340272361872, 4723.976380118112, 4730.195866702652, 4850.466448690641, 4853.1264372413125, 4870.269459581055, 4893.681910675812, 4917.041176970492, 4958.132326842806, 4689.366935463703, 4749.311349854252, 4752.9762351188365, 4818.9036219275595, 4876.341693871317, 4787.904241915142, 4797.040591881638, 4797.736124513151, 4804.975975120137, 4807.9038419231765, 4755.50067242938, 4761.452432970218, 4763.595094416979, 4772.331873537708, 4772.7136371817805, 5167.819126330561, 5214.400343960455, 5217.713025783581, 5220.138677118271, 5226.8693282667855, 5463.48096930791, 5534.4742249486235, 5542.86142846428, 5549.667019978814, 5556.6943818089985, 5504.559635229172, 5514.117741161395, 5519.254900588409, 5520.861978450531, 5556.499915007628, 5212.426633070321, 5248.317718696545, 5255.76349064293, 5262.368515778055, 5319.388270348882, 5490.203920431515, 5512.062949298629, 5651.378348381675, 5675.3757086720425, 5696.943030569641, 5486.231927530149, 5504.2294078829, 5507.228987941691, 5514.558835293167, 5562.3881373048935, 5580.609357345028, 5592.5246354059545, 5594.496495315441, 5595.104783234663, 5598.468145526169, 5312.309399778004, 5354.892902141935, 5442.12925931849, 5469.972650136724, 5499.257600223998, 5526.47498487643, 5583.190437386556, 5586.1062230043, 5586.441355864381, 5589.664620122724, 4268.0823622921225, 4270.961140115134, 4273.1240095780295, 4296.119295544406, 4322.524522302544, 3744.251149770057, 3755.0424641716186, 3836.3286424875537, 3860.0735823402183, 3883.2427676602792, 5174.586033117342, 5277.604179686539, 5287.365516138011, 5347.171188465794, 5348.786048558014, 5545.057340252167, 5577.776888924479, 5585.58108141891, 5590.049691552445, 5605.831825045255, 5272.578193744491, 5284.682919024871, 5288.418273989858, 5297.125974214288, 5299.682019078868, 4730.574248317599, 4770.427548694179, 4794.9280760788615, 4826.831060912921, 4844.176489996709, 5730.283714535683, 5751.884962300647, 5754.079347304495, 5754.165645981393, 5808.477237048602, 5538.944610553843, 5540.252065971204, 5543.25166102571, 5546.057170280981, 5569.526590239713, 5609.579281553982, 5652.491275785199, 5664.971675141763, 5716.342620598684, 5738.5696072795545, 5450.236966824568, 5454.4545545445135, 5457.754401052041, 5507.7246137693755, 5510.1459273812625, 5486.972565137149, 5515.310586176728, 5533.3083364579425, 5533.972330138485, 5541.6120871540215, 5246.868828279324, 5305.442928492607, 5409.594280428905, 5412.648177868426, 5432.239486471976, 5449.509544141047, 5530.05988981866, 5537.058700020925, 5579.497845193952, 5582.0, 5479.123340265698, 5479.369872464558, 5480.3971563128825, 5482.972585137049, 5485.0949593318255, 5299.735013249399, 5368.812091576776, 5446.618736688394, 5512.2558454608115, 5596.048671725735, 5380.112281473513, 5446.891062178814, 5453.072977593739, 5498.5876059296515, 5508.03609368367], "value": 5137.090172392746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.7303592577972, 586.5483577645214, 593.3384276531667, 593.5815250248576, 613.4478968927964, 31340.843295783518, 41788.58211417885, 42595.36106958398, 42736.78631606846, 42813.14373712524, 43681.34477982833, 44194.11611767771, 44219.77890110545, 44276.3358549622, 44287.55712442875, 8051.597420128999, 8352.079021824984, 8906.688265910694, 9066.45601263923, 9072.047435019327, 10505.52725127371, 10775.461226938662, 10781.892181078167, 11177.161712871526, 11178.552857885676, 10941.070009049241, 11040.668779936615, 11056.336619802838, 11056.391898445583, 11058.723531911726, 10734.355938643706, 10754.731131721692, 10795.46022698862, 10803.621873234477, 10809.405482698448, 10652.946735266274, 10740.355578665305, 10744.0, 10745.0, 10747.677569672922, 41833.58166418358, 41948.1610367794, 42219.7889010553, 42264.366034509505, 42268.788656056524, 2887.5524293734293, 3321.983390083058, 3352.547406100194, 3449.3618680543927, 3874.9925019495136, 31593.84203078993, 31760.682393176005, 31823.84088079568, 31931.680683193103, 33564.328713425835, 4184.51878034027, 4189.7695626740515, 4345.50026746925, 4364.803583838735, 4410.29435290352, 231944.0, 232260.0, 232798.0, 233147.0, 233988.0, 34304.313913721584, 56600.43399566034, 56792.0, 56895.0, 56974.43025569774, 35145.0, 36624.81687591545, 36906.44640330397, 37146.62853371432, 37166.62833371686, 15647.139407332706, 15798.447054353042, 15800.051996880224, 15802.288896999433, 15816.920915395349, 11709.941450292694, 11897.940510297392, 12711.55509557161, 12995.935020324838, 12998.415071321813, 8499.575021249037, 8501.872471912926, 8535.189157030072, 8637.827243455096, 8641.179087986757, 3315.784474009182, 3346.3140056288403, 3388.203772113551, 3396.0, 3398.04854640701, 1003.2945485672174, 1014.2443879309961, 1038.5326603028668, 1123.1351859068473, 1148.3741360958297, 31393.0, 31713.412109755143, 31715.365692686017, 31730.841345793586, 31901.52147717786, 1045.4929359260752, 1092.2136062035322, 1098.9999100818218, 1115.7154925493946, 1168.4333098447246, 16118.75821862673, 16862.83137168637, 16864.91567542179, 16901.492955211364, 16935.491935241964, 485373.0, 488056.0, 488894.0, 489322.0, 490115.0, 56327.0, 56739.0, 56922.146167807514, 56929.71535142298, 56994.71502642543, 1231.4950870143198, 1273.6943133647858, 1318.413306078805, 1364.222393235846, 1374.4502199120432, 27960.30099247535, 31775.841120794248, 31896.0, 32009.83995080103, 32415.675843241264, 48191.5180848187, 51868.48131518788, 53205.0, 53238.46761532335, 58731.706341468016, 436345.0, 440640.0, 440744.0, 441204.0, 442769.0, 27166.456670866868, 27699.307517312227, 27846.44307113887, 27929.441411171258, 41679.0, 42376.364354535326, 42712.0, 42764.57235427606, 46253.53746462627, 47280.0, 39446.2110757789, 39869.0, 40040.0, 40715.79642101771, 42239.0, 39056.41415378828, 39606.40590391089, 40327.1934561313, 40658.59341406548, 41461.1707765837, 39218.215635687695, 40164.59835401725, 40539.0, 40868.59131408648, 40989.79505102456, 33092.669073308956, 36022.0, 36399.0, 36820.81589592035, 37226.6277337234, 26478.338041549116, 26670.333241668337, 26960.0, 27298.317542061606, 27465.17604471869], "value": 18897.504164844413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.59998601489394, 392.6073926073926, 407.5089517131855, 409.30213985155314, 425.0415313468131, 13491.730165396686, 15455.536333909973, 18886.244550217976, 19114.426567203005, 19845.503862403446, 18575.25698972043, 19065.237390504364, 19149.808501914977, 19160.83846165381, 19696.11367488463, 4731.621470282369, 5518.586106042053, 5951.196588460546, 5979.760809567612, 5991.221141251631, 4286.614204721574, 4532.161550113239, 5874.9118763218585, 5883.617564858292, 5912.054071348563, 6337.588056776318, 6643.0, 6654.567453115532, 6695.3304669533145, 6744.730210791562, 6423.229212494507, 6566.080748695163, 6600.471962243057, 6603.141591593062, 6724.159480064992, 5653.773849046033, 5762.164486149527, 5812.709364531756, 5834.941650583524, 5837.0, 18470.53823654406, 18747.81252187488, 18753.531161721065, 19643.607127857507, 22781.658275125887, 2261.1746712450004, 2475.405902583367, 2571.0, 2784.568391899259, 2984.179350678559, 13948.721025579533, 14470.348834302482, 14789.556313310617, 14888.776668349983, 15377.384904603914, 1913.2155816115326, 1925.0217959895378, 1962.519182800209, 1963.0, 2054.065400242886, 77810.6109469449, 80382.59808700977, 81123.18876811274, 81432.59283703603, 83085.0, 10631.84052239217, 10821.783564328669, 11044.613438529614, 11123.777524449466, 11176.696971665804, 15683.686326273411, 15757.606059848365, 15759.448419305269, 15766.605834853992, 15796.0, 7747.2640099190485, 7820.960895195488, 7906.5651389173, 8058.234467725557, 8196.385271104691, 7481.9251807482315, 7603.695852165852, 7841.333486653584, 7847.1368149503505, 7882.0, 4701.741404222732, 4762.928556071662, 4783.402074740658, 4797.880052998633, 4876.902461950741, 1794.9910250448663, 1837.9148382983674, 1934.516370907273, 1970.881747095179, 2049.1496029148034, 830.6179157587457, 893.5130353957109, 973.2262851033446, 1013.3261381181579, 1036.8548403223404, 18984.0, 19519.219231230592, 19643.31248406299, 19828.20687172526, 20023.499412514804, 950.538988590533, 964.5611246882652, 989.248171389749, 1011.6914341126027, 1038.6676263595577, 10507.31702439339, 10857.239993200401, 10964.725881852857, 10977.39624320654, 11069.335839849635, 417066.0, 449004.0, 457494.0, 459549.0, 459906.0, 88530.55734721414, 89567.55216223878, 89686.55156724305, 90897.54551227202, 95119.0, 933.5472295936465, 934.6635211323918, 954.61815273891, 957.3011701457974, 1016.755978565139, 16486.83513164853, 16489.67020659604, 17119.0, 17453.825461745728, 17754.5561360967, 40473.797631012836, 40604.59395406008, 40803.1839363217, 40949.795251023555, 41279.0, 56520.0, 57175.42824571701, 57460.42539574551, 58070.0, 59678.403215967286, 8222.218889205516, 8389.454685445426, 8556.828863422821, 8696.478211307342, 8788.472691638523, 9557.808843823224, 11676.70808229801, 12565.623031309075, 12687.746245075232, 13051.934740326238, 7790.0, 11155.330680159217, 11407.319279969035, 11569.0, 11810.704732381415, 11077.003069723763, 11355.489002995051, 11392.658220253406, 11682.357470339213, 11829.408529573315, 11594.072474201876, 11620.418979051183, 11865.347405892759, 11970.084786434129, 12302.323372214614, 8478.152184781473, 11020.724481888017, 11500.424978751196, 11832.645020649394, 11931.76136477283, 11260.662180134608, 11574.537018519164, 11586.42067896585, 11829.17195796286, 12238.0], "value": 9290.388378714528, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.4378392426952, 1482.1033274868705, 1610.798650168729, 1731.3161301285984, 1783.5897743518983, 7932.405069619787, 8245.134260902609, 8326.167383261678, 9038.954805225965, 9048.502332371725, 8406.705765298217, 8693.69572064978, 8740.344474164447, 8960.820783584324, 8974.596143173556, 2305.0549274797295, 2326.9883650581723, 2343.0979073056824, 2347.882605869708, 2350.9177178798745, 1980.6434841728483, 2280.623697089978, 2301.7698230176934, 2319.3158018384615, 2354.8233882458885, 2016.969745453812, 2253.5605556916407, 2317.4206448387904, 2319.489712263308, 2327.592671282519, 2229.7881701238357, 2236.608593496148, 2249.111600917645, 2250.8086812620945, 2307.0541078157876, 2255.819534437241, 2259.186692790594, 2263.7283525976823, 2264.230161745015, 2266.841321107523, 8816.426932249384, 8844.73465796027, 8889.911100888972, 8898.37711360205, 8904.643814247422, 4974.179260422026, 5122.667026643294, 5178.145605975047, 5181.481851814826, 5192.740362981874, 3179.1098492422157, 3184.4268031754277, 3184.4268031754277, 3238.8542515586855, 3260.96739032609, 1129.2772625519674, 1129.9378534180616, 1138.6128716236437, 1142.0749193153572, 1160.628598848369, 12164.452599633038, 12191.19602491432, 12199.0, 12203.145779795417, 12208.511659533608, 4245.490541135022, 4403.779811009501, 4514.841980530666, 4561.2473941799235, 4591.747453890068, 10272.435016074187, 10273.794524109626, 10274.126699230499, 10280.691579252634, 10288.794224115625, 5138.100832354323, 5138.87152821175, 5140.280360749423, 5142.074426603247, 5145.07388670043, 4677.111348843709, 4711.45818230901, 4741.5021422750115, 4747.667663263607, 4772.427308722906, 3728.4780130781714, 3802.7147963902266, 3826.464294998647, 3831.885043448701, 3905.5703872573995, 1078.1267173589417, 1119.5353928119903, 1212.3271584270638, 1234.8765123487578, 1254.347739175642, 871.808202195516, 918.4672889723944, 922.5064590444081, 945.6926498887889, 951.1202138022302, 5668.093105103164, 5974.9402505974385, 5988.820335389945, 6030.728617212236, 6399.328070552618, 834.9582520873932, 915.5925613102106, 944.6646440513656, 947.7346343023964, 962.3985009369144, 4069.2268468991388, 4093.181363727207, 4099.795010249476, 4125.422440858282, 4263.957360426356, 10524.421156836295, 10890.564377424815, 10929.344239345664, 10999.945000274947, 11001.449927503592, 10847.40339281347, 10857.51141198648, 10860.076893463985, 10879.0, 10904.890951090387, 7632.93138960546, 7806.843863122705, 7931.325837303893, 7934.960325198453, 7969.521828690297, 5778.508826749605, 5813.941860581509, 5851.444112809277, 5853.063509838576, 6069.089636554552, 10030.147437467605, 10050.145737612092, 10073.597056117966, 10117.342372745748, 10185.9490702546, 10033.548490317808, 10257.538410771682, 10516.894831051592, 10519.0, 10527.31572447819, 7278.67245973943, 7332.376747976482, 7381.711669382508, 7382.298681625237, 7385.187629360874, 7849.979502664617, 8112.634931427981, 8164.877526837221, 8170.01959764832, 8179.591020448835, 7560.6219689016425, 7726.072871255486, 7826.647800848861, 7914.327282181079, 7938.3252423542335, 7535.712162938445, 7605.543667379975, 7639.312461878458, 7795.22047795216, 7825.726099586487, 6792.524523283323, 6838.14523184602, 6917.100776898971, 6942.201646810681, 6993.055937448583, 5095.108356037605, 5206.55744261742, 5264.31563896691, 5314.920276195783, 5427.294451721251, 5164.948350516447, 5180.766865491138, 5242.97378513105, 5272.78908843642, 5287.920681189862], "value": 4576.387288772708, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.8970274363575, 331.61863856564946, 336.966303369663, 340.5334691472683, 345.70096866210736, 5381.838544843651, 5441.972790136054, 5479.506844384, 5483.1501117326825, 5493.670379777216, 5114.488551144884, 5118.257852611369, 5208.947910520894, 5223.164293713006, 5261.263423120766, 4201.70588058836, 4204.453421055258, 4210.3894935234375, 4217.40956266123, 4234.17433600448, 4225.323948168294, 4225.936610950838, 4240.173166232586, 4241.363795430695, 4251.4898212214575, 3894.415837624365, 3894.9805250973704, 4126.5667104954, 4145.440365550642, 4165.458490396244, 4127.40152677863, 4134.627883490485, 4144.274751918432, 4153.397757325201, 4153.460050193456, 3698.445233215012, 3712.7772333659796, 3717.3494638438438, 3718.665320121202, 3719.758215715997, 5163.5352818246165, 5194.63637545372, 5205.27126202332, 5212.0128102002, 5276.419593844674, 4818.7831547580445, 4828.758562071883, 4829.058333624945, 4836.960053588496, 4865.270209468573, 5587.106063029895, 5595.0, 5639.6334238274385, 5641.746121424505, 5666.376698563155, 4051.2728289973297, 4077.5106987161435, 4108.5275193352845, 4112.177564487085, 4145.17096580685, 5757.4818266355815, 5765.884682306372, 5787.421257874221, 5792.507636850873, 5799.246098007275, 4222.619964203236, 4245.235857545671, 4247.8088486018205, 4256.063665993476, 4270.252705776476, 4198.811053502539, 4222.1766755483, 4258.488981322199, 4267.701260911706, 4319.503257125471, 4810.975945120252, 4814.470408255089, 4817.9036419271415, 4840.201366774513, 4841.878953026132, 5581.6371935824045, 5596.38439771633, 5606.635568688022, 5618.831435056954, 5669.971650141723, 1388.8472567768729, 1423.181670539444, 1460.1531111955253, 1463.6487243061588, 1472.337448148316, 956.4834989105805, 1016.4358780876685, 1045.895410458948, 1048.9108425783893, 1057.6562617149457, 5437.640589852537, 5491.423400542885, 5495.560355171577, 5506.889862202734, 5512.80705175325, 5548.4174161713245, 5756.222909907193, 5756.740946657411, 5775.682337471395, 5825.737841797045, 5424.620276580601, 5433.864153396117, 5435.565154787608, 5439.428859969726, 5469.699166545878, 3048.1008102609785, 3066.7853250272715, 3067.3405217877817, 3068.3403068340413, 3082.1370016395445, 5731.312242530839, 5978.103284507271, 5982.222311099529, 5998.0, 6002.879942401128, 5842.912356314659, 5852.912206316909, 5915.822525324247, 5928.970355148197, 5929.495992840657, 5739.741711623071, 5945.581290757832, 5946.316173640001, 5971.19388882504, 5996.5202783777195, 5765.91351129725, 5776.855578610568, 5779.190913272229, 5782.5663075268685, 5784.190213370048, 5642.6614403135945, 5714.342850572071, 5722.484976352148, 5805.287440205065, 5823.155642431909, 5888.3228428731245, 5930.229070220844, 5938.703064846654, 5951.672658003851, 6088.169001414363, 4180.435641188401, 4195.643370313557, 4202.726822756511, 4220.95779042218, 4221.240176768211, 5865.530757539472, 5865.794697185578, 5871.588988770745, 5872.265966754156, 5877.471027607536, 5496.725163741717, 5659.490645841894, 5667.3765885753355, 5701.0, 5716.971415142898, 5617.943820561742, 5632.633878797865, 5646.774129034957, 5670.603057785916, 5676.772929082956, 5284.656497327662, 5343.866403339947, 5564.4991950724625, 5677.261955945701, 5686.545076393796, 5623.493885550321, 5626.35296940857, 5633.4084921082695, 5644.209810626598, 5644.6613203207935, 5396.487333703292, 5399.433059528693, 5468.699221542854, 5500.697461639648, 5513.751881165437], "value": 4317.598060039685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5359603843634, 759.6239861268671, 785.399169635229, 823.991760082399, 839.8488272111017, 15261.771073433907, 16697.91651041743, 16718.832811671895, 16721.247543860525, 16734.414295499646, 14300.14199148052, 14321.355539000744, 14359.712805743879, 14367.78448323276, 14390.352434140463, 767.4321002458197, 784.4077721320396, 784.8469548438056, 785.2226295967008, 785.45018487059, 646.079336944854, 663.8074958262098, 778.381186956371, 791.5804623549499, 794.5510786405691, 847.6270441005969, 853.1638993786094, 854.9615267312955, 856.7900864288258, 861.6854847980504, 838.1953324808192, 850.0437008365589, 852.7100785732849, 852.9530875801828, 853.2917678326974, 624.3912185619031, 625.399616368287, 625.4808508937571, 625.5464788028688, 625.6308777821107, 10347.94826025865, 10804.405757683324, 14380.209088500129, 14786.556403307917, 14795.186264755434, 14326.856731432761, 15087.4719384821, 15317.846821531864, 15363.4622788203, 15629.687406251925, 11731.354775487345, 11861.169718119734, 12011.279323240633, 12027.304909805125, 12059.0, 3816.084139806454, 3826.6747326477284, 3835.654791068789, 3875.399313106473, 3907.765534067965, 76419.6179019107, 76544.23455765427, 76564.34356564355, 77217.0, 77275.0, 11245.887541124484, 11321.150913681508, 11573.0, 11697.12271579635, 11756.94121529387, 21174.364769056952, 21202.15191392327, 21217.893910530347, 21220.151193952377, 21228.78771212299, 8169.856697076227, 8488.787780305542, 8490.745277641681, 8565.48607083577, 8666.263367613823, 4583.449986001701, 4626.930596041062, 4698.271767875985, 4772.761361931959, 4863.80544778212, 3291.8189499577275, 3400.0309911675054, 3402.0644322811427, 3405.965940340565, 3407.931841363159, 568.6190252530814, 568.8236646639555, 569.4248808703239, 572.4504475703288, 594.9910751338733, 527.6965744696814, 723.6924307169432, 761.0638914135644, 763.7785042337771, 788.8461749958703, 8617.61220745068, 8689.348298877609, 8809.0, 8922.02212541729, 9320.161185493338, 623.4856243599049, 644.3041515163612, 658.7463826426861, 683.6684208159039, 712.4620911212002, 4175.62419382257, 4341.60925516705, 4482.574155455227, 4488.281874900001, 4493.236149854532, 71802.28197717956, 72257.0, 80334.59832700799, 127198.36400818122, 127582.36208818897, 62408.37591624026, 63450.682746585975, 65224.0, 108604.0, 108705.45647271712, 54655.18017229824, 74153.25846741571, 87544.5622771882, 88527.0, 94011.52994234985, 8559.657613695383, 8742.169493898069, 8882.0, 9035.593398297224, 9272.594629200563, 51197.488025120765, 51519.0, 52086.0, 54154.187687183934, 54761.45238547723, 70234.64882675554, 76233.0, 78947.60526197332, 79469.60265198637, 80490.59754701423, 11147.777044458902, 11593.536258549564, 11717.0, 11836.408179590813, 11908.40457977115, 13036.0, 13432.462701491831, 13449.46202151903, 13684.931575342458, 14173.503927362493, 12186.390680466118, 12363.505459781509, 12597.811032834697, 12681.340794306223, 12982.15615984958, 12310.446029928495, 12378.690532736753, 12386.132970691964, 12505.124641275024, 12590.307533085403, 11628.302301861915, 11656.650300491, 11997.0, 12386.876131238932, 12395.194312369667, 10079.596816127272, 10172.542235599563, 10313.0, 10472.633457828939, 10500.894991049992, 9849.704508864745, 10081.092701656886, 10164.960747292178, 10201.591936322464, 10264.948675256575], "value": 7227.152438206183, "unit": "score"}], "name": "dromaeo_css", "value": 7106.489918344644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 111.0, 111.0, 112.0, 111.0, 113.0, 113.0, 111.0, 114.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 129.0, 123.0, 165.0, 125.0, 127.0, 122.0, 121.0, 160.0, 127.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 159.0, 160.0, 160.0, 162.0, 163.0, 160.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 111.0, 77.0, 77.0, 76.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 81.0, 82.0, 81.0, 101.0, 82.0, 81.0, 112.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 50.0, 52.0, 52.0, 51.0, 52.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0], "value": 59.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 85.0, 79.0, 80.0, 80.0, 83.0, 79.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 130.0, 138.0, 131.0, 133.0, 140.0, 128.0, 164.0, 129.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 165.0, 165.0, 174.0, 169.0, 167.0, 165.0, 164.0, 170.0, 169.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 65.0, 66.0, 66.0, 76.0, 68.0, 64.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1499.7, "alertThreshold": 2.0}]} 04:54:30 INFO - Return code: 0 04:54:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:30 INFO - # TBPL SUCCESS # 04:54:30 INFO - Running post-action listener: _resource_record_post_action 04:54:30 INFO - [mozharness: 2016-10-06 11:54:30.640909Z] Finished run-tests step (success) 04:54:30 INFO - Running post-run listener: _resource_record_post_run 04:54:30 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 395526144; Read time: 0; Write time: 353556 04:54:30 INFO - TinderboxPrint: CPU usage
13.1% 04:54:30 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:54:30 INFO - TinderboxPrint: I/O write bytes / time
395,526,144 / 353,556 04:54:30 INFO - TinderboxPrint: CPU idle
8,302.4 (86.9%) 04:54:30 INFO - TinderboxPrint: CPU user
1,197.7 (12.5%) 04:54:30 INFO - TinderboxPrint: Swap in / out
0 / 0 04:54:30 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107192320; Read time: 0; Write time: 117452 04:54:30 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288333824; Read time: 0; Write time: 236104 04:54:31 INFO - Running post-run listener: _upload_blobber_files 04:54:31 INFO - Blob upload gear active. 04:54:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:31 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 04:54:31 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'] 04:54:31 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 04:54:31 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:35 INFO - (blobuploader) - INFO - Done attempting. 04:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:36 INFO - (blobuploader) - INFO - Done attempting. 04:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:54:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:37 INFO - (blobuploader) - INFO - Done attempting. 04:54:37 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:37 INFO - Return code: 0 04:54:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5367a457293870fd1ee7a76aca378c89d45eda8e3217c36594bf41fe84c02b398a1dc50ebf32173e6e1dee6dcaa4b7a1190d73b524d4083b1387539c959f84f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bbcdd221a0119ec4833021a7fe2b86ad9acd6dc7ab2359dcd11f3f2db745693abeac05945ae7ba26d21d7bcf108812ce5856dad8e6787ce04076905e47dfc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1d906def60dc5852b0d2b672bf4209a02a5bee220964bb914778e42e25aad274df96b77cc9e06006b6764222b02eb8e1d903e1e7ebe6f641cf64bc805ba346e"} 04:54:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:37 INFO - Contents: 04:54:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5367a457293870fd1ee7a76aca378c89d45eda8e3217c36594bf41fe84c02b398a1dc50ebf32173e6e1dee6dcaa4b7a1190d73b524d4083b1387539c959f84f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bbcdd221a0119ec4833021a7fe2b86ad9acd6dc7ab2359dcd11f3f2db745693abeac05945ae7ba26d21d7bcf108812ce5856dad8e6787ce04076905e47dfc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1d906def60dc5852b0d2b672bf4209a02a5bee220964bb914778e42e25aad274df96b77cc9e06006b6764222b02eb8e1d903e1e7ebe6f641cf64bc805ba346e"} 04:54:37 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:37 INFO - Copying logs to upload dir... 04:54:37 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.199349 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-10-06 04:54:37.117292) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:54:37.122585) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 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/5367a457293870fd1ee7a76aca378c89d45eda8e3217c36594bf41fe84c02b398a1dc50ebf32173e6e1dee6dcaa4b7a1190d73b524d4083b1387539c959f84f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bbcdd221a0119ec4833021a7fe2b86ad9acd6dc7ab2359dcd11f3f2db745693abeac05945ae7ba26d21d7bcf108812ce5856dad8e6787ce04076905e47dfc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1d906def60dc5852b0d2b672bf4209a02a5bee220964bb914778e42e25aad274df96b77cc9e06006b6764222b02eb8e1d903e1e7ebe6f641cf64bc805ba346e"} build_url:https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/BwyS-ak6SpCHlxGWqk6-EA/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/5367a457293870fd1ee7a76aca378c89d45eda8e3217c36594bf41fe84c02b398a1dc50ebf32173e6e1dee6dcaa4b7a1190d73b524d4083b1387539c959f84f4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3bbcdd221a0119ec4833021a7fe2b86ad9acd6dc7ab2359dcd11f3f2db745693abeac05945ae7ba26d21d7bcf108812ce5856dad8e6787ce04076905e47dfc7b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1d906def60dc5852b0d2b672bf4209a02a5bee220964bb914778e42e25aad274df96b77cc9e06006b6764222b02eb8e1d903e1e7ebe6f641cf64bc805ba346e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 04:54:37.148364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:54:37.148704) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1475753633.615132-778608120 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 04:54:37.233284) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:54:37.233638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 04:54:37.233953) ========= ========= Total master_lag: 0.15 =========