builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-020 starttime: 1468844201.44 results: success (0) buildid: 20160718023044 builduid: 129cbaccaa354d5aabc322f22abe817a revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.441139) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.441635) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.441916) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.457411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.457792) ========= 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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 05:16:43-- 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% 40.6M=0s 2016-07-18 05:16:43 (40.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.633159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.633503) ========= 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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014847 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:41.683151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:16:41.683526) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc547f508f58108db8b9ad9c2b94f130c07de194 --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 bc547f508f58108db8b9ad9c2b94f130c07de194 --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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 05:16:43,642 truncating revision to first 12 chars 2016-07-18 05:16:43,642 Setting DEBUG logging. 2016-07-18 05:16:43,642 attempt 1/10 2016-07-18 05:16:43,642 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc547f508f58?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 05:16:44,917 unpacking tar archive at: fx-team-bc547f508f58/testing/mozharness/ program finished with exit code 0 elapsedTime=1.593174 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 05:16:43.291334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:43.291672) ========= script_repo_revision: bc547f508f58108db8b9ad9c2b94f130c07de194 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:43.292069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:43.292442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 05:16:43.303231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-18 05:16:43.303624) ========= /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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:16:45 INFO - MultiFileLogger online at 20160718 05:16:45 in /builds/slave/test 05:16:45 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 05:16:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:45 INFO - {'append_to_log': False, 05:16:45 INFO - 'base_work_dir': '/builds/slave/test', 05:16:45 INFO - 'blob_upload_branch': 'Fx-Team', 05:16:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:45 INFO - 'branch': 'Fx-Team', 05:16:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:45 INFO - 'config_files': ('talos/linux_config.py',), 05:16:45 INFO - 'default_actions': ('clobber', 05:16:45 INFO - 'read-buildbot-config', 05:16:45 INFO - 'download-and-extract', 05:16:45 INFO - 'populate-webroot', 05:16:45 INFO - 'create-virtualenv', 05:16:45 INFO - 'install', 05:16:45 INFO - 'run-tests'), 05:16:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:45 INFO - 'download_minidump_stackwalk': True, 05:16:45 INFO - 'download_symbols': 'ondemand', 05:16:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:45 INFO - 'installer_path': 'installer.exe', 05:16:45 INFO - 'log_level': 'info', 05:16:45 INFO - 'log_name': 'talos', 05:16:45 INFO - 'log_to_console': True, 05:16:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:16:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:16:45 INFO - 'opt_config_files': (), 05:16:45 INFO - 'pip_index': False, 05:16:45 INFO - 'sps_profile': False, 05:16:45 INFO - 'sps_profile_interval': 0, 05:16:45 INFO - 'suite': 'dromaeojs', 05:16:45 INFO - 'system_bits': '32', 05:16:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:45 INFO - 'title': 'talos-linux64-ix-020', 05:16:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:45 INFO - 'use_talos_json': True, 05:16:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:45 INFO - 'work_dir': 'build'} 05:16:45 INFO - ##### 05:16:45 INFO - ##### Running clobber step. 05:16:45 INFO - ##### 05:16:45 INFO - Running pre-action listener: _resource_record_pre_action 05:16:45 INFO - Running main action method: clobber 05:16:45 INFO - rmtree: /builds/slave/test/build 05:16:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:46 INFO - Running post-action listener: _resource_record_post_action 05:16:46 INFO - ##### 05:16:46 INFO - ##### Finished clobber step (success) 05:16:46 INFO - ##### 05:16:46 INFO - ##### 05:16:46 INFO - ##### Running read-buildbot-config step. 05:16:46 INFO - ##### 05:16:46 INFO - Running pre-action listener: _resource_record_pre_action 05:16:46 INFO - Running main action method: read_buildbot_config 05:16:46 INFO - Using buildbot properties: 05:16:46 INFO - { 05:16:46 INFO - "project": "", 05:16:46 INFO - "product": "firefox", 05:16:46 INFO - "script_repo_revision": "production", 05:16:46 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:16:46 INFO - "repository": "", 05:16:46 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:16:46 INFO - "buildid": "20160718023044", 05:16:46 INFO - "pgo_build": "True", 05:16:46 INFO - "basedir": "/builds/slave/test", 05:16:46 INFO - "buildnumber": 295, 05:16:46 INFO - "slavename": "talos-linux64-ix-020", 05:16:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:16:46 INFO - "platform": "ubuntu64_hw", 05:16:46 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:16:46 INFO - "branch": "fx-team", 05:16:46 INFO - "repo_path": "integration/fx-team", 05:16:46 INFO - "revision": "bc547f508f58108db8b9ad9c2b94f130c07de194", 05:16:46 INFO - "stage_platform": "linux64-pgo", 05:16:46 INFO - "builduid": "129cbaccaa354d5aabc322f22abe817a", 05:16:46 INFO - "slavebuilddir": "test" 05:16:46 INFO - } 05:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:16:46 INFO - Running post-action listener: _resource_record_post_action 05:16:46 INFO - ##### 05:16:46 INFO - ##### Finished read-buildbot-config step (success) 05:16:46 INFO - ##### 05:16:46 INFO - ##### 05:16:46 INFO - ##### Running download-and-extract step. 05:16:46 INFO - ##### 05:16:46 INFO - Running pre-action listener: _resource_record_pre_action 05:16:46 INFO - Running main action method: download_and_extract 05:16:46 INFO - mkdir: /builds/slave/test/build/tests 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:16:46 INFO - Downloaded 1361 bytes. 05:16:46 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:16:46 INFO - Using the following test package requirements: 05:16:46 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:46 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:16:46 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:16:46 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'jsshell-linux-x86_64.zip'], 05:16:46 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:16:46 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:16:46 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:16:46 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:16:46 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:16:46 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:16:46 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:16:46 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:46 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:47 INFO - Downloaded 24334234 bytes. 05:16:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:49 INFO - Return code: 0 05:16:49 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:49 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:16:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:16:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:16:50 INFO - Downloaded 24334234 bytes. 05:16:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:16:51 INFO - Return code: 0 05:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:51 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:16:52 INFO - Downloaded 14403317 bytes. 05:16:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:16:53 INFO - Return code: 0 05:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:53 INFO - https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:16:54 INFO - Downloaded 60818167 bytes. 05:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:54 INFO - mkdir: /builds/slave/test/properties 05:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:54 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:54 INFO - Contents: 05:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:16:55 INFO - Running post-action listener: _resource_record_post_action 05:16:55 INFO - Running post-action listener: set_extra_try_arguments 05:16:55 INFO - ##### 05:16:55 INFO - ##### Finished download-and-extract step (success) 05:16:55 INFO - ##### 05:16:55 INFO - ##### 05:16:55 INFO - ##### Running populate-webroot step. 05:16:55 INFO - ##### 05:16:55 INFO - Running pre-action listener: _resource_record_pre_action 05:16:55 INFO - Running main action method: populate_webroot 05:16:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:55 INFO - '--tppagecycles', 05:16:55 INFO - '7'], 05:16:55 INFO - 'tests': ['tsvgm']}}, 05:16:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['damp', 'tps']}, 05:16:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'tests': ['damp', 'tps']}, 05:16:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['dromaeo_dom']}, 05:16:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['basic_compositor_video']}, 05:16:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:16:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['a11yr', 05:16:55 INFO - 'ts_paint', 05:16:55 INFO - 'tpaint', 05:16:55 INFO - 'sessionrestore', 05:16:55 INFO - 'sessionrestore_no_auto_restore', 05:16:55 INFO - 'tabpaint']}, 05:16:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['tsvgx', 05:16:55 INFO - 'tsvgr_opacity', 05:16:55 INFO - 'tart', 05:16:55 INFO - 'tscrollx', 05:16:55 INFO - 'cart']}, 05:16:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:55 INFO - 'tsvgr_opacity', 05:16:55 INFO - 'tart', 05:16:55 INFO - 'tscrollx', 05:16:55 INFO - 'cart']}, 05:16:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'talos_options': ['--disable-e10s'], 05:16:55 INFO - 'tests': ['tp5o']}, 05:16:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'tests': ['tp5o']}, 05:16:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'talos_options': ['--disable-e10s', 05:16:55 INFO - '--xperf_path', 05:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:55 INFO - 'tests': ['tp5n']}, 05:16:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:55 INFO - 'talos_options': ['--xperf_path', 05:16:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:55 INFO - 'tests': ['tp5n']}}, 05:16:55 INFO - 'talos.zip': {'path': '', 05:16:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:55 INFO - Running post-action listener: _resource_record_post_action 05:16:55 INFO - ##### 05:16:55 INFO - ##### Finished populate-webroot step (success) 05:16:55 INFO - ##### 05:16:55 INFO - ##### 05:16:55 INFO - ##### Running create-virtualenv step. 05:16:55 INFO - ##### 05:16:55 INFO - Running pre-action listener: _resource_record_pre_action 05:16:55 INFO - Running main action method: create_virtualenv 05:16:55 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:55 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 05:16:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:55 INFO - Using real prefix '/usr' 05:16:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:57 INFO - Installing pip.................done. 05:16:57 INFO - Return code: 0 05:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:57 INFO - Using env: {'DISPLAY': ':0', 05:16:57 INFO - 'HOME': '/home/cltbld', 05:16:57 INFO - 'LANG': 'en_US.UTF-8', 05:16:57 INFO - 'LANGUAGE': 'en_US:en', 05:16:57 INFO - 'LOGNAME': 'cltbld', 05:16:57 INFO - 'MAIL': '/var/mail/cltbld', 05:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:57 INFO - 'MOZ_NO_REMOTE': '1', 05:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:57 INFO - 'NO_EM_RESTART': '1', 05:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:57 INFO - 'PWD': '/builds/slave/test', 05:16:57 INFO - 'SHELL': '/bin/bash', 05:16:57 INFO - 'SHLVL': '1', 05:16:57 INFO - 'TERM': 'linux', 05:16:57 INFO - 'TMOUT': '86400', 05:16:57 INFO - 'USER': 'cltbld', 05:16:57 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:57 INFO - '_': '/tools/buildbot/bin/python'} 05:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:58 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 05:16:58 INFO - Cleaning up... 05:16:58 INFO - Return code: 0 05:16:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:58 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 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:16:58 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 05:16:58 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 05:16:58 INFO - Using env: {'DISPLAY': ':0', 05:16:58 INFO - 'HOME': '/home/cltbld', 05:16:58 INFO - 'LANG': 'en_US.UTF-8', 05:16:58 INFO - 'LANGUAGE': 'en_US:en', 05:16:58 INFO - 'LOGNAME': 'cltbld', 05:16:58 INFO - 'MAIL': '/var/mail/cltbld', 05:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:58 INFO - 'MOZ_NO_REMOTE': '1', 05:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:16:58 INFO - 'NO_EM_RESTART': '1', 05:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:58 INFO - 'PWD': '/builds/slave/test', 05:16:58 INFO - 'SHELL': '/bin/bash', 05:16:58 INFO - 'SHLVL': '1', 05:16:58 INFO - 'TERM': 'linux', 05:16:58 INFO - 'TMOUT': '86400', 05:16:58 INFO - 'USER': 'cltbld', 05:16:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:58 INFO - '_': '/tools/buildbot/bin/python'} 05:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:58 INFO - Downloading/unpacking psutil>=3.1.1 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:00 INFO - Installing collected packages: psutil 05:17:00 INFO - Running setup.py install for psutil 05:17:00 INFO - building 'psutil._psutil_linux' extension 05:17:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:17:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:17:00 INFO - building 'psutil._psutil_posix' extension 05:17:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:17:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:00 INFO - Successfully installed psutil 05:17:00 INFO - Cleaning up... 05:17:00 INFO - Return code: 0 05:17:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:17:00 INFO - Using env: {'DISPLAY': ':0', 05:17:00 INFO - 'HOME': '/home/cltbld', 05:17:00 INFO - 'LANG': 'en_US.UTF-8', 05:17:00 INFO - 'LANGUAGE': 'en_US:en', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MAIL': '/var/mail/cltbld', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SHLVL': '1', 05:17:00 INFO - 'TERM': 'linux', 05:17:00 INFO - 'TMOUT': '86400', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - '_': '/tools/buildbot/bin/python'} 05:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:01 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 05:17:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:03 INFO - Installing collected packages: mozsystemmonitor 05:17:03 INFO - Running setup.py install for mozsystemmonitor 05:17:03 INFO - Successfully installed mozsystemmonitor 05:17:03 INFO - Cleaning up... 05:17:03 INFO - Return code: 0 05:17:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:03 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:03 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 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:03 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 05:17:03 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 05:17:03 INFO - Using env: {'DISPLAY': ':0', 05:17:03 INFO - 'HOME': '/home/cltbld', 05:17:03 INFO - 'LANG': 'en_US.UTF-8', 05:17:03 INFO - 'LANGUAGE': 'en_US:en', 05:17:03 INFO - 'LOGNAME': 'cltbld', 05:17:03 INFO - 'MAIL': '/var/mail/cltbld', 05:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:03 INFO - 'MOZ_NO_REMOTE': '1', 05:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:03 INFO - 'NO_EM_RESTART': '1', 05:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:03 INFO - 'PWD': '/builds/slave/test', 05:17:03 INFO - 'SHELL': '/bin/bash', 05:17:03 INFO - 'SHLVL': '1', 05:17:03 INFO - 'TERM': 'linux', 05:17:03 INFO - 'TMOUT': '86400', 05:17:03 INFO - 'USER': 'cltbld', 05:17:03 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:03 INFO - '_': '/tools/buildbot/bin/python'} 05:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:03 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:05 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:05 INFO - warning: no files found matching '*.txt' 05:17:05 INFO - no previously-included directories found matching 'build' 05:17:05 INFO - no previously-included directories found matching 'dist' 05:17:05 INFO - no previously-included directories found matching '.git*' 05:17:05 INFO - Installing collected packages: jsonschema, functools32 05:17:05 INFO - Running setup.py install for functools32 05:17:05 INFO - warning: no files found matching '*.txt' 05:17:05 INFO - no previously-included directories found matching 'build' 05:17:05 INFO - no previously-included directories found matching 'dist' 05:17:05 INFO - no previously-included directories found matching '.git*' 05:17:05 INFO - Successfully installed jsonschema functools32 05:17:05 INFO - Cleaning up... 05:17:05 INFO - Return code: 0 05:17:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:17:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:17:05 INFO - Using env: {'DISPLAY': ':0', 05:17:05 INFO - 'HOME': '/home/cltbld', 05:17:05 INFO - 'LANG': 'en_US.UTF-8', 05:17:05 INFO - 'LANGUAGE': 'en_US:en', 05:17:05 INFO - 'LOGNAME': 'cltbld', 05:17:05 INFO - 'MAIL': '/var/mail/cltbld', 05:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:05 INFO - 'MOZ_NO_REMOTE': '1', 05:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:05 INFO - 'NO_EM_RESTART': '1', 05:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:05 INFO - 'PWD': '/builds/slave/test', 05:17:05 INFO - 'SHELL': '/bin/bash', 05:17:05 INFO - 'SHLVL': '1', 05:17:05 INFO - 'TERM': 'linux', 05:17:05 INFO - 'TMOUT': '86400', 05:17:05 INFO - 'USER': 'cltbld', 05:17:05 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:05 INFO - '_': '/tools/buildbot/bin/python'} 05:17:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:08 INFO - Downloading docopt-0.6.1.tar.gz 05:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:08 INFO - Running setup.py install for blobuploader 05:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:08 INFO - Running setup.py install for requests 05:17:09 INFO - Running setup.py install for docopt 05:17:09 INFO - Successfully installed blobuploader requests docopt 05:17:09 INFO - Cleaning up... 05:17:09 INFO - Return code: 0 05:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:09 INFO - Using env: {'DISPLAY': ':0', 05:17:09 INFO - 'HOME': '/home/cltbld', 05:17:09 INFO - 'LANG': 'en_US.UTF-8', 05:17:09 INFO - 'LANGUAGE': 'en_US:en', 05:17:09 INFO - 'LOGNAME': 'cltbld', 05:17:09 INFO - 'MAIL': '/var/mail/cltbld', 05:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:09 INFO - 'MOZ_NO_REMOTE': '1', 05:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:09 INFO - 'NO_EM_RESTART': '1', 05:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:09 INFO - 'PWD': '/builds/slave/test', 05:17:09 INFO - 'SHELL': '/bin/bash', 05:17:09 INFO - 'SHLVL': '1', 05:17:09 INFO - 'TERM': 'linux', 05:17:09 INFO - 'TMOUT': '86400', 05:17:09 INFO - 'USER': 'cltbld', 05:17:09 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:09 INFO - '_': '/tools/buildbot/bin/python'} 05:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:09 INFO - Running setup.py (path:/tmp/pip-5FAqXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:09 INFO - Running setup.py (path:/tmp/pip-eGRoAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:09 INFO - Running setup.py (path:/tmp/pip-a8GTKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:09 INFO - Running setup.py (path:/tmp/pip-TvDQMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:09 INFO - Running setup.py (path:/tmp/pip-FlcJdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:09 INFO - Running setup.py (path:/tmp/pip-wCbxdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:09 INFO - Running setup.py (path:/tmp/pip-H7JZ6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:09 INFO - Running setup.py (path:/tmp/pip-o7nOQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:10 INFO - Running setup.py (path:/tmp/pip-W8wFNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:10 INFO - Running setup.py (path:/tmp/pip-i7Unbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:10 INFO - Running setup.py (path:/tmp/pip-rEb5Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:10 INFO - Running setup.py (path:/tmp/pip-fZJK4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:10 INFO - Running setup.py (path:/tmp/pip-HzD9qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:10 INFO - Running setup.py (path:/tmp/pip-NFsZ7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:10 INFO - Running setup.py (path:/tmp/pip-kwggyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:10 INFO - Running setup.py (path:/tmp/pip-f9aQO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:10 INFO - Running setup.py (path:/tmp/pip-rPP23y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:10 INFO - Running setup.py install for manifestparser 05:17:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:10 INFO - Running setup.py install for mozcrash 05:17:10 INFO - Running setup.py install for mozdebug 05:17:10 INFO - Running setup.py install for mozdevice 05:17:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for mozfile 05:17:11 INFO - Running setup.py install for mozhttpd 05:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for mozinfo 05:17:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for mozInstall 05:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for mozleak 05:17:11 INFO - Running setup.py install for mozlog 05:17:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for moznetwork 05:17:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:11 INFO - Running setup.py install for mozprocess 05:17:11 INFO - Running setup.py install for mozprofile 05:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Running setup.py install for mozrunner 05:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Running setup.py install for mozscreenshot 05:17:12 INFO - Running setup.py install for moztest 05:17:12 INFO - Running setup.py install for mozversion 05:17:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:12 INFO - Cleaning up... 05:17:12 INFO - Return code: 0 05:17:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:12 INFO - Using env: {'DISPLAY': ':0', 05:17:12 INFO - 'HOME': '/home/cltbld', 05:17:12 INFO - 'LANG': 'en_US.UTF-8', 05:17:12 INFO - 'LANGUAGE': 'en_US:en', 05:17:12 INFO - 'LOGNAME': 'cltbld', 05:17:12 INFO - 'MAIL': '/var/mail/cltbld', 05:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:12 INFO - 'MOZ_NO_REMOTE': '1', 05:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:12 INFO - 'NO_EM_RESTART': '1', 05:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:12 INFO - 'PWD': '/builds/slave/test', 05:17:12 INFO - 'SHELL': '/bin/bash', 05:17:12 INFO - 'SHLVL': '1', 05:17:12 INFO - 'TERM': 'linux', 05:17:12 INFO - 'TMOUT': '86400', 05:17:12 INFO - 'USER': 'cltbld', 05:17:12 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:12 INFO - '_': '/tools/buildbot/bin/python'} 05:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:12 INFO - Running setup.py (path:/tmp/pip-OPYNMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:12 INFO - Running setup.py (path:/tmp/pip-Oo_em0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:12 INFO - Running setup.py (path:/tmp/pip-nK1LBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:12 INFO - Running setup.py (path:/tmp/pip-cxT5R6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:13 INFO - Running setup.py (path:/tmp/pip-v9MEYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:13 INFO - Running setup.py (path:/tmp/pip-_XlNn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:13 INFO - Running setup.py (path:/tmp/pip-9av668-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:13 INFO - Running setup.py (path:/tmp/pip-tSmlvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:13 INFO - Running setup.py (path:/tmp/pip-__b4Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:13 INFO - Running setup.py (path:/tmp/pip-w7TOTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:13 INFO - Running setup.py (path:/tmp/pip-Lf6coh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:13 INFO - Running setup.py (path:/tmp/pip-18Ar71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:13 INFO - Running setup.py (path:/tmp/pip-TLuVYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:13 INFO - Running setup.py (path:/tmp/pip-eNtBPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:13 INFO - Running setup.py (path:/tmp/pip-itSGJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:13 INFO - Running setup.py (path:/tmp/pip-sT2tZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:13 INFO - Running setup.py (path:/tmp/pip-4l3oyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17: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 05:17:15 INFO - Downloading blessings-1.6.tar.gz 05:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:15 INFO - Installing collected packages: blessings 05:17:15 INFO - Running setup.py install for blessings 05:17:16 INFO - Successfully installed blessings 05:17:16 INFO - Cleaning up... 05:17:16 INFO - Return code: 0 05:17:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:16 INFO - Reading from file tmpfile_stdout 05:17:16 INFO - Current package versions: 05:17:16 INFO - argparse == 1.2.1 05:17:16 INFO - blessings == 1.6 05:17:16 INFO - blobuploader == 1.2.4 05:17:16 INFO - docopt == 0.6.1 05:17:16 INFO - functools32 == 3.2.3-2 05:17:16 INFO - jsonschema == 2.5.1 05:17:16 INFO - manifestparser == 1.1 05:17:16 INFO - mozInstall == 1.12 05:17:16 INFO - mozcrash == 0.17 05:17:16 INFO - mozdebug == 0.1 05:17:16 INFO - mozdevice == 0.48 05:17:16 INFO - mozfile == 1.2 05:17:16 INFO - mozhttpd == 0.7 05:17:16 INFO - mozinfo == 0.9 05:17:16 INFO - mozleak == 0.1 05:17:16 INFO - mozlog == 3.2 05:17:16 INFO - moznetwork == 0.27 05:17:16 INFO - mozprocess == 0.23 05:17:16 INFO - mozprofile == 0.28 05:17:16 INFO - mozrunner == 6.12 05:17:16 INFO - mozscreenshot == 0.1 05:17:16 INFO - mozsystemmonitor == 0.3 05:17:16 INFO - moztest == 0.7 05:17:16 INFO - mozversion == 1.4 05:17:16 INFO - psutil == 3.1.1 05:17:16 INFO - requests == 1.2.3 05:17:16 INFO - wsgiref == 0.1.2 05:17:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:17:16 INFO - Using env: {'DISPLAY': ':0', 05:17:16 INFO - 'HOME': '/home/cltbld', 05:17:16 INFO - 'LANG': 'en_US.UTF-8', 05:17:16 INFO - 'LANGUAGE': 'en_US:en', 05:17:16 INFO - 'LOGNAME': 'cltbld', 05:17:16 INFO - 'MAIL': '/var/mail/cltbld', 05:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:16 INFO - 'MOZ_NO_REMOTE': '1', 05:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:16 INFO - 'NO_EM_RESTART': '1', 05:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:16 INFO - 'PWD': '/builds/slave/test', 05:17:16 INFO - 'SHELL': '/bin/bash', 05:17:16 INFO - 'SHLVL': '1', 05:17:16 INFO - 'TERM': 'linux', 05:17:16 INFO - 'TMOUT': '86400', 05:17:16 INFO - 'USER': 'cltbld', 05:17:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:16 INFO - '_': '/tools/buildbot/bin/python'} 05:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:17:16 INFO - Cleaning up... 05:17:16 INFO - Return code: 0 05:17:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x205d180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', '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 05:17:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:16 INFO - Using env: {'DISPLAY': ':0', 05:17:16 INFO - 'HOME': '/home/cltbld', 05:17:16 INFO - 'LANG': 'en_US.UTF-8', 05:17:16 INFO - 'LANGUAGE': 'en_US:en', 05:17:16 INFO - 'LOGNAME': 'cltbld', 05:17:16 INFO - 'MAIL': '/var/mail/cltbld', 05:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:16 INFO - 'MOZ_NO_REMOTE': '1', 05:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:16 INFO - 'NO_EM_RESTART': '1', 05:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:16 INFO - 'PWD': '/builds/slave/test', 05:17:16 INFO - 'SHELL': '/bin/bash', 05:17:16 INFO - 'SHLVL': '1', 05:17:16 INFO - 'TERM': 'linux', 05:17:16 INFO - 'TMOUT': '86400', 05:17:16 INFO - 'USER': 'cltbld', 05:17:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:16 INFO - '_': '/tools/buildbot/bin/python'} 05:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:16 INFO - Cleaning up... 05:17:16 INFO - Return code: 0 05:17:16 INFO - Running post-action listener: _resource_record_post_action 05:17:16 INFO - Running post-action listener: _start_resource_monitoring 05:17:16 INFO - Starting resource monitoring. 05:17:16 INFO - ##### 05:17:16 INFO - ##### Finished create-virtualenv step (success) 05:17:16 INFO - ##### 05:17:16 INFO - ##### 05:17:16 INFO - ##### Running install step. 05:17:16 INFO - ##### 05:17:16 INFO - Running pre-action listener: _resource_record_pre_action 05:17:16 INFO - Running main action method: install 05:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:17 INFO - Reading from file tmpfile_stdout 05:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:17 INFO - Reading from file tmpfile_stdout 05:17:17 INFO - Output received: 05:17:17 INFO - Usage: mozinstall [options] installer 05:17:17 INFO - Options: 05:17:17 INFO - -h, --help show this help message and exit 05:17:17 INFO - -d DEST, --destination=DEST 05:17:17 INFO - Directory to install application into. [default: 05:17:17 INFO - "/builds/slave/test"] 05:17:17 INFO - --app=APP Application being installed. [default: firefox] 05:17:17 INFO - mkdir: /builds/slave/test/build/application 05:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:17:34 INFO - Reading from file tmpfile_stdout 05:17:34 INFO - Output received: 05:17:34 INFO - /builds/slave/test/build/application/firefox/firefox 05:17:34 INFO - Running post-action listener: _resource_record_post_action 05:17:34 INFO - ##### 05:17:34 INFO - ##### Finished install step (success) 05:17:34 INFO - ##### 05:17:34 INFO - ##### 05:17:34 INFO - ##### Running run-tests step. 05:17:34 INFO - ##### 05:17:34 INFO - Running pre-action listener: _resource_record_pre_action 05:17:34 INFO - Running main action method: run_tests 05:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:34 INFO - Python 2.7.3 05:17:34 INFO - Return code: 0 05:17:34 INFO - grabbing minidump binary from tooltool 05:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205b3b0>, '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 0x205c2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x205c740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:17:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:17:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:34 INFO - Return code: 0 05:17:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:17:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:17:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 05:17:34 INFO - Using env: {'DISPLAY': ':0', 05:17:34 INFO - 'HOME': '/home/cltbld', 05:17:34 INFO - 'LANG': 'en_US.UTF-8', 05:17:34 INFO - 'LANGUAGE': 'en_US:en', 05:17:34 INFO - 'LOGNAME': 'cltbld', 05:17:34 INFO - 'MAIL': '/var/mail/cltbld', 05:17:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:34 INFO - 'MOZ_NO_REMOTE': '1', 05:17:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:34 INFO - 'NO_EM_RESTART': '1', 05:17:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:34 INFO - 'PWD': '/builds/slave/test', 05:17:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:34 INFO - 'SHELL': '/bin/bash', 05:17:34 INFO - 'SHLVL': '1', 05:17:34 INFO - 'TERM': 'linux', 05:17:34 INFO - 'TMOUT': '86400', 05:17:34 INFO - 'USER': 'cltbld', 05:17:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970', 05:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:34 INFO - '_': '/tools/buildbot/bin/python'} 05:17:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 05:17:34 INFO - mozversion application_buildid: 20160718023044 05:17:34 INFO - mozversion application_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:17:34 INFO - mozversion application_display_name: Nightly 05:17:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:34 INFO - mozversion application_name: Firefox 05:17:34 INFO - mozversion application_remotingname: firefox 05:17:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:34 INFO - mozversion application_vendor: Mozilla 05:17:34 INFO - mozversion application_version: 50.0a1 05:17:34 INFO - mozversion platform_buildid: 20160718023044 05:17:34 INFO - mozversion platform_changeset: bc547f508f58108db8b9ad9c2b94f130c07de194 05:17:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:34 INFO - mozversion platform_version: 50.0a1 05:17:34 INFO - using testdate: 1468844254 05:17:34 INFO - actual date: 1468844254 05:17:34 INFO - starting webserver on 'localhost:47972' 05:17:34 INFO - SUITE-START | Running 2 tests 05:17:34 INFO - TEST-START | dromaeo_css 05:17:34 INFO - operating with platform_type : linux_ 05:17:34 INFO - Initialising browser for dromaeo_css test... 05:17:34 INFO - TEST-INFO | started process 21850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPQ8Wk/profile http://localhost:47972/getInfo.html) 05:17:38 INFO - PROCESS | 21850 | JavaScript error: , line 0: uncaught exception: undefined 05:17:38 INFO - PROCESS | 21850 | __metrics Screen width/height:1600/1200 05:17:38 INFO - PROCESS | 21850 | colorDepth:24 05:17:38 INFO - PROCESS | 21850 | Browser inner width/height: 1024/697 05:17:38 INFO - PROCESS | 21850 | __metrics 05:17:39 INFO - PROCESS | 21850 | 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" 05:17:39 INFO - PROCESS | 21850 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:40 INFO - TEST-INFO | 21850: exit 0 05:17:40 INFO - Browser initialized. 05:17:40 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:40 INFO - TEST-INFO | started process 21938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsPQ8Wk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:52 INFO - PROCESS | 21938 | RSS: Main: 158056448 05:17:52 INFO - PROCESS | 21938 | 05:18:44 INFO - PROCESS | 21938 | 1468844324110 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] 05:20:52 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47972/tests/dromaeo/cssquery-ext.html) 05:20:53 INFO - PROCESS | 21938 | RSS: Main: 255557632 05:20:53 INFO - PROCESS | 21938 | 05:23:55 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-ext.html (next: http://localhost:47972/tests/dromaeo/cssquery-jquery.html) 05:23:56 INFO - PROCESS | 21938 | RSS: Main: 245800960 05:23:56 INFO - PROCESS | 21938 | 05:26:58 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47972/tests/dromaeo/cssquery-mootools.html) 05:26:58 INFO - PROCESS | 21938 | RSS: Main: 243253248 05:26:58 INFO - PROCESS | 21938 | 05:30:00 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47972/tests/dromaeo/cssquery-prototype.html) 05:30:01 INFO - PROCESS | 21938 | RSS: Main: 246624256 05:30:01 INFO - PROCESS | 21938 | 05:33:04 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47972/tests/dromaeo/cssquery-yui.html) 05:33:04 INFO - PROCESS | 21938 | RSS: Main: 219697152 05:33:04 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | Cycle 1(1): loaded http://localhost:47972/tests/dromaeo/cssquery-yui.html (next: http://localhost:47972/tests/dromaeo/cssquery-dojo.html) 05:36:07 INFO - PROCESS | 21938 | RSS: Main: 278499328 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | __start_tp_report 05:36:07 INFO - PROCESS | 21938 | _x_x_mozilla_page_load 05:36:07 INFO - PROCESS | 21938 | _x_x_mozilla_page_load_details 05:36:07 INFO - PROCESS | 21938 | |i|pagename|runs| 05:36:07 INFO - PROCESS | 21938 | |0;dojo.html;3094.7214750672433;3107.6892310768926;3110.393473272712;3124.218945263684;3157.842107894605;5281.8943621127555;5353.678779273237;5402.29770129883;5493.2309476673245;5502.532284755795;5339.332583427072;5345.7594408251625;5357.249985002093;5404.405515393303;5413.621046526745;4808.735519546432;4892.3884514435695;4931.630127740415;4943.382077240345;5096.031753966753;4996.400431948171;5008.2738002989545;5036.82371117011;5064.088464076464;5066;4651.325557794101;4778.880527986794;4779.139754844126;4796.640251981098;4922.655414121013;4918.557329840296;4921.704697718113;4930.03864246472;4965.32968049316;5016.799328026875;4934.333864928225;4944.208926571731;4982.227754697991;4985.850424487235;5029;5258.894822103574;5317.548008419289;5361.463853614608;5424.810131645373;5431.076716958127;5766.913496297559;5810.389909059572;5819.388964158787;5841.85395365115;5843.620164689281;5632.07070833312;5838.5329173666005;5851.590388672795;5855.648661080349;5856.355800861902;5293.550048245904;5313.654612450178;5366.6511676741275;5421.4578542146255;5427.972860135674;5905.379935106838;5906.379830117861;5918.940810591925;5920.052791553331;5923.851903702356;5525.668459892419;5609.411011843697;5659.26429564154;5664.660120392789;5667.064934285797;5690.4025077367105;5816.592838501264;5819.970900145472;5820.82537523875;5828.79599214034;5688.544916406678;5726.713664316768;5740.54075673945;5742.655440673573;5745.511631511285;5590.440955904458;5706.3152421709665;5733.455321744427;5746.367899531048;5746.798862039808;4381.496127945264;4390.736555806662;4394.824207031683;4431.33529970507;4432.069265454226;3896.337622604164;3915.060385507458;3922.0979174789386;3949.9012524686536;3950.822213000422;5221.66059206158;5306.973465132727;5445.809396671098;5468.890622187613;5495.505404513613;5865.765369385177;5887.470127688529;5894.32215295238;5910.083936989773;5917.467427931507;5560.304961879765;5569.888602227933;5574.442555744393;5578.693171875586;5579.2746942897975;4863.562279394871;4980.750962451935;5005.1491246488185;5010.799568017239;5030.2957585938;6009.399060094043;6018.578699491081;6024.307204671519;6029.155918171459;6029.186059881948;5839.970800145972;5840;5840.153177789111;5840.415958404125;5844.15259787337;5774.566907481872;5929.0217114175675;5943.316518600243;5991.610545314541;6034;5661.037623604079;5731.254936858349;5731.971340143273;5732.627379220337;5740.913886291793;5654.236678048411;5825.417458254141;5835.533157347487;5840.065589505829;5840.591158618856;5596.636218645775;5619.381867994599;5647.237622921018;5652.095664693629;5663.122216056518;5617.43825617435;5650.886982260414;5656.151577263443;5656.3495198051105;5662.462066103713;5462.863428414322;5547.583931205095;5594.832155035356;5606.971965140148;5609.635373700697;5629.043062679272;5765.336986246635;5778.248827652378;5792.594518383841;5797.739101740347;5601.691906945157;5644.745986430538;5651.406602306699;5654.123610840326;5657.32112146545 05:36:07 INFO - PROCESS | 21938 | |1;ext.html;597.1281928384558;633.6388258692546;633.8827316946363;639.8336432527542;652.8759535688217;33452.66547334526;36030.27939441209;36047;42894.14211715764;44171.558284417224;45383.773081134634;45866.77066614662;45879.99999999992;45885.31172032414;45969.77015114928;8986.505742184161;9125.72622821313;9125.771855703593;9131.634734610607;9141.771455713628;9024.77438064047;9127.452352858816;9133.908660913405;9135.862962055575;9136.63453461864;9086.77283067922;9151.816963660724;9162.312826538004;9172;9172.266218702487;9099;9131.13254240846;9139.588718507717;9146.314026447977;9149.5882685279;9010.053944335881;9077.727668169966;9082.228010619105;9086.318526110568;9091;43101.784491077655;43424.78287608542;43508.782456087836;43537.56462435398;43548.34677479808;3522.295540891832;3611.5846677632144;3653;3671.0822294426393;3772.3398405278967;32906.50640240398;33230.83384583086;33244.6675533244;33494.49758253628;34779;4494.393256910341;4639.188142075157;4644.489106198315;4727.290906364038;4776.164171270048;364009.17995410116;364402;368909;369951;370142;57794.422055779745;57871.71064144652;58021.70989145027;58180.41819581835;58181;35769;36691.63308366935;36695;38905.610943890766;59718.40281597216;17371.478855634352;17456.738148927776;17489.82510174882;17553.122343882755;17565.736513952303;13215.471381144647;13306.800397994039;13391.397387117602;13399.330033498481;13399.53101641438;19827.900860495603;19956.60086798285;19962.20151193965;20013.09941052656;20018.399448016582;7132.4294056475355;7187.31720486553;7267.963660181771;7345.55926644403;7364.668589913466;961.6634178037771;1050.6742909698019;1075.134516714037;1094.6442406217852;1122.1247427006947;33385;33449.83275083609;33568.328633427685;33580;33603.83198084043;1137.5961533655598;1152.9769404611861;1176.5764324843049;1204.602481181208;1204.903607711381;17466.563335916704;17548;17692.911535442498;17705.203265853066;17712;635338;636839;637108;638431;638927;58542;60217.698911506035;60304.39695603075;60315.39684603186;60393.396066038775;1220.8351872497099;1237.5297386992886;1255.742572772561;1352.4252192818012;1367.7743172376645;27013.86493067522;35728.64271357253;36032.63967360293;36660.81669591635;36715.44926826046;55187.724061379435;57430;59061.409385905594;59214.40785592261;63398.36601633925;480208;481745;483797;486184;487975;36487.08782280358;37593.81203093967;45297.320540191264;45672.77163614161;45817.312740308254;48832;49039.50960490349;49229.75385123052;49730.25404619006;50408.747956259984;39823.20353592854;41438.79280603577;41641.79179104085;42288.78855605702;42379.7881010593;40971;41288.174236514504;41782.94496875675;42080.78959605182;42290;36567;42033;42412;43441;43446;34554.481682774276;38064.42903356507;38141.4278785824;38512;38580.228395432496;28661;29041;29080.127596172148;29100.563491548066;29252.268693282836 05:36:07 INFO - PROCESS | 21938 | |2;jquery.html;390.3598099117447;396.24317553472855;403.21373322022066;410.76586345782897;413.5285774217391;14768.335424905878;19075.904620476897;20584;20625.587488250243;20631.38105856823;18465.261389544437;19218.519537011583;19266.807331926677;19830.504237394074;20370.185192592315;5427.728613569316;5556.777728890839;5557.166425036256;5557.861053473675;5581.581381396391;3943.2902077626018;5498.917516237239;5513.972430137844;5516.420775818541;5539.362973258067;5789;6014.308354539218;6066.150738896558;6126.7855625053135;6131.969340153293;6064.272287325527;6105.267367915856;6132.601380910249;6705.061291419205;6710.396064354231;5871.500922421599;5874.97062514689;5878.559108066912;5896.528277737771;5899.646021238739;13940.721185576333;14193.574192774233;14197.290135493184;14348.210848403334;16891;2362.232274510791;2410.3853517353136;2470.580001399748;2542.135673870874;2827.5193217153133;10165;10250.487475626263;10426.270161088727;10517.63188288414;10851.186161037953;1782.117851663422;1839.5217243516647;1937.4671965209538;1981.4154824326858;1989.9303524376721;80552.59723701402;80871;81959.59020204861;83041.58479207626;83541.58229208815;10452.425116618508;10545.209109316833;10566.207534434794;10709.196810239264;10799.460026998775;14466;14599.270036498345;14616.780748288784;14638.121712697272;14642;7991.240832121055;8040;8093.797655058553;8155.225253600898;8228.794280143044;7987.520748755093;8031.076426210943;8053.476524025919;8220.8355832883;8232.917670823335;4431.7340959542535;4458.308962110878;4486.237339652267;4521.706089104197;4612.654050946193;1929.6623090959026;1951.7950615185484;1981.8909959952052;1983.4545499987619;2060.4333808202564;903.290916630442;958.3818437108026;1033.4109557552124;1065.9946700266605;1090.5910283643634;19953.900230498755;20443.38669839907;20487.906754713895;20591.691124633144;21006.15975360999;991.5538007896475;1000.2248257600272;1002.0780881588955;1034.462079718542;1078.379931539368;10820.56717731282;11347.432628368548;11447.54209831614;11453.198276120758;11466.713332166595;494037;494908;496155;496697;508064;92054.53972730093;93869.53065234766;94298.5285073584;94847;94916;942.4157022646003;961.1541843177959;979.9759251582113;985.1576901749045;999.5402115027024;17693.469195924143;17874.46376608704;17980.820191797913;18191.999440030926;18578.25686972506;42069.36895946502;42680.35979460248;43087.56912430836;43405.13189736251;44057;56266.718666408044;56711.432885672264;60444.69777651084;61360;61383.69308153609;8680.78298042554;8725.694600688945;8742.169493898069;8895.510746908723;9027.593758280762;9718.70843874685;13632.182069075887;13902.652433689238;13976.860231397555;14066.648333791738;11019.283746556448;11294.322340659586;12094.879051209728;12134.575289864812;12297.262164269814;10441.530131143965;10456.37261764266;10697.839532407175;10954.507047183055;11029;11785.587504437304;11987.820182697442;12134.575289864812;12304.876951230732;12325;8478.152184781718;8485;8595.65617375323;8611.311095112502;8688.218060374596;8225.095239523767;11264.324140551593;12052.276863388224;12132;12185.512579497075 05:36:07 INFO - PROCESS | 21938 | |3;mootools.html;1309.8035294705787;1407.6199426154938;1475.5130806833745;1563.3199558192186;1727.8531324837381;8388.328933685305;8691.087435819243;8718.694845680402;8957.19385255327;8980.236679882202;8776.341774366916;8868.980067292263;8877.422967507107;8969.641214351419;8973.057828927951;2276.1350686739056;2301.850379725321;2302.3323236261463;2303.49323148907;2304.6888670029584;2291.9312420627407;2308.5382923415386;2318.9072437102495;2336.0655737704883;2338.240071976606;2212.4026512841524;2217.2350539063996;2237.093976939334;2239.0819763896807;2241.316398498457;2158.0936006877073;2165.0798410675557;2195.132922495621;2197.4067001909557;2198.3075331270597;2222.0667319725753;2250.5948929192737;2253.019936327686;2254.6392577187735;2256.311824893407;8801.647934082628;8958.820823583492;8964.103589641049;9019.458832470007;9073.45559266446;5144.6913185209005;5249.186376111708;5254.947450525522;5255.421903590602;5265.736713164365;3215.2765627733806;3235.3367559650214;3245.789023713451;3249.8050116992817;3263.0863358259726;1035.3994683083793;1043.5773511727687;1045.6131231444415;1085.1590017736316;1102.090775110537;12601.810972835416;12602.81095783564;12661.873381266161;12678.429470673842;12732.172408793398;4317.611414972667;4343.087951530214;4520.208963431386;4533.954660453419;4535.750533720677;9825.017498250118;9827.705168844946;9830.508474576243;9841.655542055994;9845.310828241954;5237.188235823453;5237.842864713988;5238.5547228486;5240.397354304304;5248.553872920845;4238.258304796648;4697.084068606658;4869.610431165498;4884.633652476078;4920.581750551243;3727.6086010968456;3738.1028553147594;3816.3512202925567;3824.655780979725;3850.2299540091535;1116.9441527923734;1137.221003612528;1140.2531341971023;1142.3716955674347;1146.529922731676;988.3921388346259;1001.9499025048718;1006.6677996261217;1012.5089331674133;1013.7414959185361;5982.581219314693;6210.689465526705;6309.558330916791;6357.364263573606;6397.072424498421;402.1554735056358;407.58629990559604;407.74515927545286;413.6318676378026;415.09095081770823;4415.867523974286;4428.446444194476;4481;4481.260592002283;4491.752953587584;10912.890871091346;11149.331040137618;11164.553417863357;11213.327200368005;11218.326900386002;10843.51204195813;11117.666470005914;11120.61077862271;11333.60332388379;11353.148513861493;8103.959480202561;8217;8245.381596380295;8260.8347833043;8321.334293256525;6004.579679422399;6361;6375.968120159369;6382.968085159545;6396;10485;10595.09941654968;10614.628488002883;10622.787544248917;10623.097036751962;9883.30816842814;10291.794164116825;10298.279120461795;10484.475776211311;10553.736156596147;7107.786766397016;7329.377002954595;7332.450066244946;8018.679252829821;8172.632231549714;7423.777286681408;7941.245581669732;8493.150684931457;8546.829063418822;8736.868946965673;7905.802354941173;8027.719029833927;8042.115367309474;8048.798780030546;8253.917460825314;7701.4994025390415;7740.1098873628;7807.102183248999;7859.52842829432;7927.920720792949;7371.189169191492;7373.15208750979;7437.330640242404;7460.813479662835;7533.962330188314;5019.3976722793495;5236.476352364885;5237.816676416307;5367.651102678469;5412.43169467216;5102.719350435762;5172.5344718975475;5188.9740551297;5253.921191182212;5362.839114826562 05:36:07 INFO - PROCESS | 21938 | |4;prototype.html;322.5838668118127;328.15009126362713;331.2331951532204;333.49309050243613;337.25298463902465;5281.815136470224;5309.380638905132;5319.0957537218665;5322.414534401213;5322.654027488215;5247.973760131194;5248.160294352904;5262.158244614383;5319.707416092114;5320.547753440953;3945.940810887832;4034.878953631381;4120.175964807036;4146.937795933063;4152.252594532983;4054.9391759123637;4108.876733697994;4112.362583799516;4123.814428350732;4135.214309281227;3919.7648141111627;4075.7758323292205;4087.3255912774357;4102.876913692594;4114.847842604061;3845.7115716321387;4004.939925901114;4054.493188351456;4119.382092686121;4143.212789569972;3608.8736894208578;3613.2050948791225;3625.9456108158397;3626.2022355082104;3631.1466805300734;5134.614903882224;5137.845864624067;5144.151215049513;5229.267902493654;5231.869203269911;4590.563896429834;4690.1557719610455;4698.600618947394;4713;4717.339572459859;5410.5401040911565;5433.4566543345745;5444.673319600836;5458.590605704588;5518.475744804237;4015.6185162409524;4019.8191081401405;4025.818838152261;4037.697172712029;4042.3532234842282;5557.41647127054;5639.379668236491;5696.515796157331;5698.458646428583;5702.517345490161;4080.7755573443746;4090.2024105299774;4105.7331273467125;4107.691923105719;4117.444145040441;4179.477565304337;4181.142865712522;4185.372194170899;4188.350805625133;4201.663866890642;4451.332300154938;4638.420197475316;4679.298105284234;4752.596029337545;4764.356811830427;5504.174373843875;5513.669179849222;5530.170474428868;5531;5541.889162216814;1394.2958805803005;1400.404827948118;1409.4150927365029;1412.7457057729503;1421.3532842556613;875.5884734175055;881.2069137776053;897.2194191053694;912.7946212102356;918.1782304837267;5192.299039629677;5337.251315572484;5346.759395827197;5352.65207761502;5370.785168593213;5635.506590753454;5637.238972738628;5650.23721797552;5653.738504598194;5655.208270842086;5116.951025039858;5331.706756128373;5337.5463085637375;5338.119210330329;5417.26866872975;2995.655499617528;3002.714742099497;3007.4661922419723;3019.6829332920165;3023.2441889527618;5838.9124163137585;5846.766129354864;5858.802948894165;5859.853503662443;5865.266841644794;5505.889882202334;5784.537237021028;5789.6104934816185;5790.276215473066;5830.8542286442325;5854.151148083504;5877.4122587740885;5882.94107060716;5888.322842873039;5894.7326324839505;5442.700651464207;5672.9221447924765;5691.772329106955;5706.001449746361;5714.457126572969;5651.971740141273;5660.688662123458;5675.716214189191;5675.914861277001;5688.260526131577;5826.504747096545;5830.358660547421;5837.744884849778;5916.201312822714;5926.733297001559;3932.193900250499;4092.7107960992194;4100.958990410058;4121.835126594902;4130.896727581834;5771.5671324649975;5774.105013722879;5789.623674461147;5802.854928626818;5826.912596310974;5533.750981205775;5659.54723622101;5664.745086471036;5681.204631351697;5686.9715651421475;5571.415001424792;5583.888322233452;5588.972055139699;5590.580706446952;5686.630369026;5267.683938963674;5443.59173062014;5484.436935473371;5501.614886957875;5516.9448305518035;5460.34475862899;5544.946460172554;5595.944040559705;5599.880023995136;5609.158626206102;5369.140937449989;5408.053590621704;5415.83752487426;5426.972865135649;5433.918491222714 05:36:07 INFO - PROCESS | 21938 | |5;yui.html;781.4959351218464;792.805762588166;817.9877301840473;830.7839961609983;862.633380813155;14124.152550846944;14877.851221487808;14909.552713418587;14976.550703478886;14987.10077395357;13289.933550332258;13440.327983600806;13442.327883605829;13443.529476468326;13448.327583620829;667.072768851297;777.4557809533321;786.182370334851;790.3874497264637;800.027966021284;810.623060276971;810.6959890041235;811.817341098254;812.5774597209447;814.9307308878723;852.1989330029752;854.8632218844986;855.4396870050095;856.5203486047802;858.356232825381;685.1572565744137;816.4162623724036;841.2092632925031;841.3353450773882;841.7643059943196;612.7518355066205;614.8678034222619;615.0436071908181;615.3969110271914;616.1158737212115;13074.084814063019;13113.737725245537;13151.934240328832;13162.934185329108;13344.733105337937;13215.86784132156;13373;13411.329433528284;13532.864671353258;13942.790858137136;12603.558875439407;12743.171693839964;12841.29372884491;12887.00251461025;12893.484260629564;4359.564043595647;4378.605925466723;4471.195184866723;4497.078098989699;4513.796879140414;74341.25658743452;74590;75221.62389188074;79279;80110.59944700297;10153;10353.534090965924;10403.271770976111;10482.959214674616;10839.67480975572;21118.577628447652;21174.788252117283;21266.78733212679;21279.042443089787;21356.35930922075;8054.355651547862;8101.270885620204;8104.797380065427;8118.553479558681;8161.877571836309;4301.677374196947;4465.464144302705;4509.954900451019;4525.52481989393;4670.439547254351;3464.7574669772875;3561.6260292669413;3565.8395372208315;3577.874774382884;3584.444411116229;468.9624830013591;584.7514806207345;585.5579037826499;587.3451102021215;672.4553111979312;603.080302538632;660.8148723154445;748.8539734751671;763.8625047491394;769.707511145761;10337.483125843828;10365.481725913674;10462.424566648908;10875.51060202277;10970.561177552809;614.582084182751;686.2828344380134;699.5977313044917;737.1854101218184;760.8159851023485;4813.531872778766;5139.327220784606;5157.561607263349;5229.529342359206;5269.657472264291;129012;131371.34314328368;131478;132578.33710831383;133248;109752;114359.42820285846;116032;116099;118084;96120;97445.5127724371;97935.16189643009;100920.49539752254;102278;9963.651272205438;10052.899471005489;10182;10187.643432479828;10187.643432479828;56804.43195568157;57505.71247143738;58607;59719.70140149445;60897.39102609095;83595;87060;88716;89111.55444222737;90396.5480172595;13086.14940028895;13170.473181073034;13311.933440332736;13481;13786.448542058206;13922.51271205503;14149.787753183504;14391.712165756835;14452.2051287176;14538.345774439964;12892.935535322638;12898.012121816626;13118;13244.668883277609;13279.933600331937;12511.56209532662;13208.141470804367;13572.321383930961;13750.312484375541;13938.30308484592;12932.15940963872;13104.279264640536;13151.276679782704;13354.86645133575;13499.32503374847;10063.982009413205;10965.177611678997;11290.43547822622;11384.316940983568;11633.59282425111;11172.944135279271;11386.544538218379;11509.827352589886;11555.4800033997;11665.35840528779 05:36:07 INFO - PROCESS | 21938 | __end_tp_report 05:36:07 INFO - PROCESS | 21938 | __start_cc_report 05:36:07 INFO - PROCESS | 21938 | _x_x_mozilla_cycle_collect,881 05:36:07 INFO - PROCESS | 21938 | __end_cc_report 05:36:07 INFO - PROCESS | 21938 | __startTimestamp1468845367476__endTimestamp 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | ------- Summary: start ------- 05:36:07 INFO - PROCESS | 21938 | Number of tests: 6 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#0] dojo.html Cycles:165 Average:5376.34 Median:5606.97 stddev:616.57 (11.0%) stddev-sans-first:591.91 05:36:07 INFO - PROCESS | 21938 | Values: 3094.7 3107.7 3110.4 3124.2 3157.8 5281.9 5353.7 5402.3 5493.2 5502.5 5339.3 5345.8 5357.2 5404.4 5413.6 4808.7 4892.4 4931.6 4943.4 5096.0 4996.4 5008.3 5036.8 5064.1 5066.0 4651.3 4778.9 4779.1 4796.6 4922.7 4918.6 4921.7 4930.0 4965.3 5016.8 4934.3 4944.2 4982.2 4985.9 5029.0 5258.9 5317.5 5361.5 5424.8 5431.1 5766.9 5810.4 5819.4 5841.9 5843.6 5632.1 5838.5 5851.6 5855.6 5856.4 5293.6 5313.7 5366.7 5421.5 5428.0 5905.4 5906.4 5918.9 5920.1 5923.9 5525.7 5609.4 5659.3 5664.7 5667.1 5690.4 5816.6 5820.0 5820.8 5828.8 5688.5 5726.7 5740.5 5742.7 5745.5 5590.4 5706.3 5733.5 5746.4 5746.8 4381.5 4390.7 4394.8 4431.3 4432.1 3896.3 3915.1 3922.1 3949.9 3950.8 5221.7 5307.0 5445.8 5468.9 5495.5 5865.8 5887.5 5894.3 5910.1 5917.5 5560.3 5569.9 5574.4 5578.7 5579.3 4863.6 4980.8 5005.1 5010.8 5030.3 6009.4 6018.6 6024.3 6029.2 6029.2 5840.0 5840.0 5840.2 5840.4 5844.2 5774.6 5929.0 5943.3 5991.6 6034.0 5661.0 5731.3 5732.0 5732.6 5740.9 5654.2 5825.4 5835.5 5840.1 5840.6 5596.6 5619.4 5647.2 5652.1 5663.1 5617.4 5650.9 5656.2 5656.3 5662.5 5462.9 5547.6 5594.8 5607.0 5609.6 5629.0 5765.3 5778.2 5792.6 5797.7 5601.7 5644.7 5651.4 5654.1 5657.3 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#1] ext.html Cycles:180 Average:65363.33 Median:42653.07 stddev:135392.23 (317.4%) stddev-sans-first:135684.71 05:36:07 INFO - PROCESS | 21938 | Values: 597.1 633.6 633.9 639.8 652.9 33452.7 36030.3 36047.0 42894.1 44171.6 45383.8 45866.8 45880.0 45885.3 45969.8 8986.5 9125.7 9125.8 9131.6 9141.8 9024.8 9127.5 9133.9 9135.9 9136.6 9086.8 9151.8 9162.3 9172.0 9172.3 9099.0 9131.1 9139.6 9146.3 9149.6 9010.1 9077.7 9082.2 9086.3 9091.0 43101.8 43424.8 43508.8 43537.6 43548.3 3522.3 3611.6 3653.0 3671.1 3772.3 32906.5 33230.8 33244.7 33494.5 34779.0 4494.4 4639.2 4644.5 4727.3 4776.2 364009.2 364402.0 368909.0 369951.0 370142.0 57794.4 57871.7 58021.7 58180.4 58181.0 35769.0 36691.6 36695.0 38905.6 59718.4 17371.5 17456.7 17489.8 17553.1 17565.7 13215.5 13306.8 13391.4 13399.3 13399.5 19827.9 19956.6 19962.2 20013.1 20018.4 7132.4 7187.3 7268.0 7345.6 7364.7 961.7 1050.7 1075.1 1094.6 1122.1 33385.0 33449.8 33568.3 33580.0 33603.8 1137.6 1153.0 1176.6 1204.6 1204.9 17466.6 17548.0 17692.9 17705.2 17712.0 635338.0 636839.0 637108.0 638431.0 638927.0 58542.0 60217.7 60304.4 60315.4 60393.4 1220.8 1237.5 1255.7 1352.4 1367.8 27013.9 35728.6 36032.6 36660.8 36715.4 55187.7 57430.0 59061.4 59214.4 63398.4 480208.0 481745.0 483797.0 486184.0 487975.0 36487.1 37593.8 45297.3 45672.8 45817.3 48832.0 49039.5 49229.8 49730.3 50408.7 39823.2 41438.8 41641.8 42288.8 42379.8 40971.0 41288.2 41782.9 42080.8 42290.0 36567.0 42033.0 42412.0 43441.0 43446.0 34554.5 38064.4 38141.4 38512.0 38580.2 28661.0 29041.0 29080.1 29100.6 29252.3 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#2] jquery.html Cycles:180 Average:29188.39 Median:2166.83 stddev:82171.56 (3792.3%) stddev-sans-first:82373.62 05:36:07 INFO - PROCESS | 21938 | Values: 390.4 396.2 403.2 410.8 413.5 14768.3 19075.9 20584.0 20625.6 20631.4 18465.3 19218.5 19266.8 19830.5 20370.2 5427.7 5556.8 5557.2 5557.9 5581.6 3943.3 5498.9 5514.0 5516.4 5539.4 5789.0 6014.3 6066.2 6126.8 6132.0 6064.3 6105.3 6132.6 6705.1 6710.4 5871.5 5875.0 5878.6 5896.5 5899.6 13940.7 14193.6 14197.3 14348.2 16891.0 2362.2 2410.4 2470.6 2542.1 2827.5 10165.0 10250.5 10426.3 10517.6 10851.2 1782.1 1839.5 1937.5 1981.4 1989.9 80552.6 80871.0 81959.6 83041.6 83541.6 10452.4 10545.2 10566.2 10709.2 10799.5 14466.0 14599.3 14616.8 14638.1 14642.0 7991.2 8040.0 8093.8 8155.2 8228.8 7987.5 8031.1 8053.5 8220.8 8232.9 4431.7 4458.3 4486.2 4521.7 4612.7 1929.7 1951.8 1981.9 1983.5 2060.4 903.3 958.4 1033.4 1066.0 1090.6 19953.9 20443.4 20487.9 20591.7 21006.2 991.6 1000.2 1002.1 1034.5 1078.4 10820.6 11347.4 11447.5 11453.2 11466.7 494037.0 494908.0 496155.0 496697.0 508064.0 92054.5 93869.5 94298.5 94847.0 94916.0 942.4 961.2 980.0 985.2 999.5 17693.5 17874.5 17980.8 18192.0 18578.3 42069.4 42680.4 43087.6 43405.1 44057.0 56266.7 56711.4 60444.7 61360.0 61383.7 8680.8 8725.7 8742.2 8895.5 9027.6 9718.7 13632.2 13902.7 13976.9 14066.6 11019.3 11294.3 12094.9 12134.6 12297.3 10441.5 10456.4 10697.8 10954.5 11029.0 11785.6 11987.8 12134.6 12304.9 12325.0 8478.2 8485.0 8595.7 8611.3 8688.2 8225.1 11264.3 12052.3 12132.0 12185.5 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#3] mootools.html Cycles:180 Average:5838.04 Median:4505.98 stddev:3400.78 (75.5%) stddev-sans-first:3393.30 05:36:07 INFO - PROCESS | 21938 | Values: 1309.8 1407.6 1475.5 1563.3 1727.9 8388.3 8691.1 8718.7 8957.2 8980.2 8776.3 8869.0 8877.4 8969.6 8973.1 2276.1 2301.9 2302.3 2303.5 2304.7 2291.9 2308.5 2318.9 2336.1 2338.2 2212.4 2217.2 2237.1 2239.1 2241.3 2158.1 2165.1 2195.1 2197.4 2198.3 2222.1 2250.6 2253.0 2254.6 2256.3 8801.6 8958.8 8964.1 9019.5 9073.5 5144.7 5249.2 5254.9 5255.4 5265.7 3215.3 3235.3 3245.8 3249.8 3263.1 1035.4 1043.6 1045.6 1085.2 1102.1 12601.8 12602.8 12661.9 12678.4 12732.2 4317.6 4343.1 4520.2 4534.0 4535.8 9825.0 9827.7 9830.5 9841.7 9845.3 5237.2 5237.8 5238.6 5240.4 5248.6 4238.3 4697.1 4869.6 4884.6 4920.6 3727.6 3738.1 3816.4 3824.7 3850.2 1116.9 1137.2 1140.3 1142.4 1146.5 988.4 1001.9 1006.7 1012.5 1013.7 5982.6 6210.7 6309.6 6357.4 6397.1 402.2 407.6 407.7 413.6 415.1 4415.9 4428.4 4481.0 4481.3 4491.8 10912.9 11149.3 11164.6 11213.3 11218.3 10843.5 11117.7 11120.6 11333.6 11353.1 8104.0 8217.0 8245.4 8260.8 8321.3 6004.6 6361.0 6376.0 6383.0 6396.0 10485.0 10595.1 10614.6 10622.8 10623.1 9883.3 10291.8 10298.3 10484.5 10553.7 7107.8 7329.4 7332.5 8018.7 8172.6 7423.8 7941.2 8493.2 8546.8 8736.9 7905.8 8027.7 8042.1 8048.8 8253.9 7701.5 7740.1 7807.1 7859.5 7927.9 7371.2 7373.2 7437.3 7460.8 7534.0 5019.4 5236.5 5237.8 5367.7 5412.4 5102.7 5172.5 5189.0 5253.9 5362.8 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#4] prototype.html Cycles:180 Average:4668.61 Median:5337.83 stddev:1378.28 (25.8%) stddev-sans-first:1342.99 05:36:07 INFO - PROCESS | 21938 | Values: 322.6 328.2 331.2 333.5 337.3 5281.8 5309.4 5319.1 5322.4 5322.7 5248.0 5248.2 5262.2 5319.7 5320.5 3945.9 4034.9 4120.2 4146.9 4152.3 4054.9 4108.9 4112.4 4123.8 4135.2 3919.8 4075.8 4087.3 4102.9 4114.8 3845.7 4004.9 4054.5 4119.4 4143.2 3608.9 3613.2 3625.9 3626.2 3631.1 5134.6 5137.8 5144.2 5229.3 5231.9 4590.6 4690.2 4698.6 4713.0 4717.3 5410.5 5433.5 5444.7 5458.6 5518.5 4015.6 4019.8 4025.8 4037.7 4042.4 5557.4 5639.4 5696.5 5698.5 5702.5 4080.8 4090.2 4105.7 4107.7 4117.4 4179.5 4181.1 4185.4 4188.4 4201.7 4451.3 4638.4 4679.3 4752.6 4764.4 5504.2 5513.7 5530.2 5531.0 5541.9 1394.3 1400.4 1409.4 1412.7 1421.4 875.6 881.2 897.2 912.8 918.2 5192.3 5337.3 5346.8 5352.7 5370.8 5635.5 5637.2 5650.2 5653.7 5655.2 5117.0 5331.7 5337.5 5338.1 5417.3 2995.7 3002.7 3007.5 3019.7 3023.2 5838.9 5846.8 5858.8 5859.9 5865.3 5505.9 5784.5 5789.6 5790.3 5830.9 5854.2 5877.4 5882.9 5888.3 5894.7 5442.7 5672.9 5691.8 5706.0 5714.5 5652.0 5660.7 5675.7 5675.9 5688.3 5826.5 5830.4 5837.7 5916.2 5926.7 3932.2 4092.7 4101.0 4121.8 4130.9 5771.6 5774.1 5789.6 5802.9 5826.9 5533.8 5659.5 5664.7 5681.2 5687.0 5571.4 5583.9 5589.0 5590.6 5686.6 5267.7 5443.6 5484.4 5501.6 5516.9 5460.3 5544.9 5595.9 5599.9 5609.2 5369.1 5408.1 5415.8 5427.0 5433.9 05:36:07 INFO - PROCESS | 21938 | 05:36:07 INFO - PROCESS | 21938 | [#5] yui.html Cycles:180 Average:22523.20 Median:12410.56 stddev:34289.24 (276.3%) stddev-sans-first:34346.57 05:36:07 INFO - PROCESS | 21938 | Values: 781.5 792.8 818.0 830.8 862.6 14124.2 14877.9 14909.6 14976.6 14987.1 13289.9 13440.3 13442.3 13443.5 13448.3 667.1 777.5 786.2 790.4 800.0 810.6 810.7 811.8 812.6 814.9 852.2 854.9 855.4 856.5 858.4 685.2 816.4 841.2 841.3 841.8 612.8 614.9 615.0 615.4 616.1 13074.1 13113.7 13151.9 13162.9 13344.7 13215.9 13373.0 13411.3 13532.9 13942.8 12603.6 12743.2 12841.3 12887.0 12893.5 4359.6 4378.6 4471.2 4497.1 4513.8 74341.3 74590.0 75221.6 79279.0 80110.6 10153.0 10353.5 10403.3 10483.0 10839.7 21118.6 21174.8 21266.8 21279.0 21356.4 8054.4 8101.3 8104.8 8118.6 8161.9 4301.7 4465.5 4510.0 4525.5 4670.4 3464.8 3561.6 3565.8 3577.9 3584.4 469.0 584.8 585.6 587.3 672.5 603.1 660.8 748.9 763.9 769.7 10337.5 10365.5 10462.4 10875.5 10970.6 614.6 686.3 699.6 737.2 760.8 4813.5 5139.3 5157.6 5229.5 5269.7 129012.0 131371.3 131478.0 132578.3 133248.0 109752.0 114359.4 116032.0 116099.0 118084.0 96120.0 97445.5 97935.2 100920.5 102278.0 9963.7 10052.9 10182.0 10187.6 10187.6 56804.4 57505.7 58607.0 59719.7 60897.4 83595.0 87060.0 88716.0 89111.6 90396.5 13086.1 13170.5 13311.9 13481.0 13786.4 13922.5 14149.8 14391.7 14452.2 14538.3 12892.9 12898.0 13118.0 13244.7 13279.9 12511.6 13208.1 13572.3 13750.3 13938.3 12932.2 13104.3 13151.3 13354.9 13499.3 10064.0 10965.2 11290.4 11384.3 11633.6 11172.9 11386.5 11509.8 11555.5 11665.4 05:36:07 INFO - PROCESS | 21938 | -------- Summary: end -------- 05:36:07 INFO - PROCESS | 21938 | 05:36:08 INFO - TEST-INFO | 21938: exit 0 05:36:08 INFO - TEST-OK | dromaeo_css | took 1113708ms 05:36:08 INFO - TEST-START | kraken 05:36:08 INFO - operating with platform_type : linux_ 05:36:08 INFO - Initialising browser for kraken test... 05:36:08 INFO - TEST-INFO | started process 22129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGchxjc/profile http://localhost:47972/getInfo.html) 05:36:12 INFO - PROCESS | 22129 | JavaScript error: , line 0: uncaught exception: undefined 05:36:12 INFO - PROCESS | 22129 | __metrics Screen width/height:1600/1200 05:36:12 INFO - PROCESS | 22129 | colorDepth:24 05:36:12 INFO - PROCESS | 22129 | Browser inner width/height: 1024/697 05:36:12 INFO - PROCESS | 22129 | __metrics 05:36:13 INFO - PROCESS | 22129 | 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" 05:36:13 INFO - PROCESS | 22129 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:36:13 INFO - PROCESS | 22129 | console.error: PushService: 05:36:13 INFO - PROCESS | 22129 | stateChangeProcessEnqueue: Error transitioning state 05:36:13 INFO - PROCESS | 22129 | UnknownError 05:36:14 INFO - TEST-INFO | 22129: exit 0 05:36:14 INFO - Browser initialized. 05:36:14 INFO - Running cycle 1/1 for kraken test... 05:36:14 INFO - TEST-INFO | started process 22209 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGchxjc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:26 INFO - PROCESS | 22209 | RSS: Main: 158138368 05:36:26 INFO - PROCESS | 22209 | 05:36:28 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47972/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:29 INFO - PROCESS | 22209 | RSS: Main: 217071616 05:36:29 INFO - PROCESS | 22209 | 05:36:32 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47972/tests/kraken/driver.html?testName=audio-dft) 05:36:32 INFO - PROCESS | 22209 | RSS: Main: 205783040 05:36:32 INFO - PROCESS | 22209 | 05:36:35 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47972/tests/kraken/driver.html?testName=audio-fft) 05:36:36 INFO - PROCESS | 22209 | RSS: Main: 271089664 05:36:36 INFO - PROCESS | 22209 | 05:36:38 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47972/tests/kraken/driver.html?testName=audio-oscillator) 05:36:39 INFO - PROCESS | 22209 | RSS: Main: 181243904 05:36:39 INFO - PROCESS | 22209 | 05:36:41 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:41 INFO - PROCESS | 22209 | RSS: Main: 185470976 05:36:41 INFO - PROCESS | 22209 | 05:36:45 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47972/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:45 INFO - PROCESS | 22209 | RSS: Main: 219652096 05:36:45 INFO - PROCESS | 22209 | 05:36:48 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47972/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:49 INFO - PROCESS | 22209 | RSS: Main: 221392896 05:36:49 INFO - PROCESS | 22209 | 05:36:52 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47972/tests/kraken/driver.html?testName=json-parse-financial) 05:36:52 INFO - PROCESS | 22209 | RSS: Main: 222433280 05:36:52 INFO - PROCESS | 22209 | 05:36:54 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:55 INFO - PROCESS | 22209 | RSS: Main: 210522112 05:36:55 INFO - PROCESS | 22209 | 05:36:56 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:57 INFO - PROCESS | 22209 | RSS: Main: 214810624 05:36:57 INFO - PROCESS | 22209 | 05:36:59 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:00 INFO - PROCESS | 22209 | RSS: Main: 210759680 05:37:00 INFO - PROCESS | 22209 | 05:37:02 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:03 INFO - PROCESS | 22209 | RSS: Main: 223494144 05:37:03 INFO - PROCESS | 22209 | 05:37:05 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:06 INFO - PROCESS | 22209 | RSS: Main: 224858112 05:37:06 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | Cycle 1(1): loaded http://localhost:47972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47972/tests/kraken/driver.html?testName=ai-astar) 05:37:08 INFO - PROCESS | 22209 | RSS: Main: 267669504 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | __start_tp_report 05:37:08 INFO - PROCESS | 22209 | _x_x_mozilla_page_load 05:37:08 INFO - PROCESS | 22209 | _x_x_mozilla_page_load_details 05:37:08 INFO - PROCESS | 22209 | |i|pagename|runs| 05:37:08 INFO - PROCESS | 22209 | |0;ai-astar;105;111;111;109;112;111;110;109;109;110 05:37:08 INFO - PROCESS | 22209 | |1;audio-beat-detection;147;118;119;173;120;119;144;118;152;123 05:37:08 INFO - PROCESS | 22209 | |2;audio-dft;161;161;161;160;160;161;161;161;160;163 05:37:08 INFO - PROCESS | 22209 | |3;audio-fft;78;74;74;114;75;75;74;75;102;74 05:37:08 INFO - PROCESS | 22209 | |4;audio-oscillator;85;84;108;84;85;85;118;84;83;134 05:37:08 INFO - PROCESS | 22209 | |5;imaging-gaussian-blur;116;117;117;118;117;117;116;116;117;117 05:37:08 INFO - PROCESS | 22209 | |6;imaging-darkroom;146;146;147;146;146;146;147;146;146;146 05:37:08 INFO - PROCESS | 22209 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 05:37:08 INFO - PROCESS | 22209 | |8;json-parse-financial;52;51;51;51;50;51;51;51;51;52 05:37:08 INFO - PROCESS | 22209 | |9;json-stringify-tinderbox;63;62;62;63;63;62;62;64;63;62 05:37:08 INFO - PROCESS | 22209 | |10;stanford-crypto-aes;81;76;78;79;76;76;75;86;74;82 05:37:08 INFO - PROCESS | 22209 | |11;stanford-crypto-ccm;127;117;116;122;124;117;119;119;167;119 05:37:08 INFO - PROCESS | 22209 | |12;stanford-crypto-pbkdf2;156;165;158;160;161;158;159;154;153;154 05:37:08 INFO - PROCESS | 22209 | |13;stanford-crypto-sha256-iterative;62;64;61;61;63;65;62;62;61;62 05:37:08 INFO - PROCESS | 22209 | __end_tp_report 05:37:08 INFO - PROCESS | 22209 | __start_cc_report 05:37:08 INFO - PROCESS | 22209 | _x_x_mozilla_cycle_collect,1646 05:37:08 INFO - PROCESS | 22209 | __end_cc_report 05:37:08 INFO - PROCESS | 22209 | __startTimestamp1468845428306__endTimestamp 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | ------- Summary: start ------- 05:37:08 INFO - PROCESS | 22209 | Number of tests: 14 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:1.95 (1.8%) stddev-sans-first:1.09 05:37:08 INFO - PROCESS | 22209 | Values: 105.0 111.0 111.0 109.0 112.0 111.0 110.0 109.0 109.0 110.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:133.50 stddev:19.40 (14.5%) stddev-sans-first:19.94 05:37:08 INFO - PROCESS | 22209 | Values: 147.0 118.0 119.0 173.0 120.0 119.0 144.0 118.0 152.0 123.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 05:37:08 INFO - PROCESS | 22209 | Values: 161.0 161.0 161.0 160.0 160.0 161.0 161.0 161.0 160.0 163.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#3] audio-fft Cycles:10 Average:81.50 Median:74.50 stddev:14.30 (19.2%) stddev-sans-first:15.11 05:37:08 INFO - PROCESS | 22209 | Values: 78.0 74.0 74.0 114.0 75.0 75.0 74.0 75.0 102.0 74.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:18.34 (21.8%) stddev-sans-first:19.09 05:37:08 INFO - PROCESS | 22209 | Values: 85.0 84.0 108.0 84.0 85.0 85.0 118.0 84.0 83.0 134.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 05:37:08 INFO - PROCESS | 22209 | Values: 116.0 117.0 117.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:37:08 INFO - PROCESS | 22209 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:37:08 INFO - PROCESS | 22209 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.00 stddev:0.57 (1.1%) stddev-sans-first:0.50 05:37:08 INFO - PROCESS | 22209 | Values: 52.0 51.0 51.0 51.0 50.0 51.0 51.0 51.0 51.0 52.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 05:37:08 INFO - PROCESS | 22209 | Values: 63.0 62.0 62.0 63.0 63.0 62.0 62.0 64.0 63.0 62.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:3.74 (4.8%) stddev-sans-first:3.84 05:37:08 INFO - PROCESS | 22209 | Values: 81.0 76.0 78.0 79.0 76.0 76.0 75.0 86.0 74.0 82.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:120.50 stddev:15.25 (12.7%) stddev-sans-first:16.16 05:37:08 INFO - PROCESS | 22209 | Values: 127.0 117.0 116.0 122.0 124.0 117.0 119.0 119.0 167.0 119.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:158.50 stddev:3.71 (2.3%) stddev-sans-first:3.87 05:37:08 INFO - PROCESS | 22209 | Values: 156.0 165.0 158.0 160.0 161.0 158.0 159.0 154.0 153.0 154.0 05:37:08 INFO - PROCESS | 22209 | 05:37:08 INFO - PROCESS | 22209 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.41 05:37:08 INFO - PROCESS | 22209 | Values: 62.0 64.0 61.0 61.0 63.0 65.0 62.0 62.0 61.0 62.0 05:37:08 INFO - PROCESS | 22209 | -------- Summary: end -------- 05:37:08 INFO - PROCESS | 22209 | 05:37:09 INFO - TEST-INFO | 22209: exit 0 05:37:09 INFO - TEST-OK | kraken | took 61006ms 05:37:09 INFO - SUITE-END | took 1174s 05:37:09 INFO - Completed test suite (00:19:34) 05:37:09 INFO - javascript benchmark 05:37:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3094.7214750672433, 3107.6892310768926, 3110.393473272712, 3124.218945263684, 3157.842107894605, 5281.8943621127555, 5353.678779273237, 5402.29770129883, 5493.2309476673245, 5502.532284755795, 5339.332583427072, 5345.7594408251625, 5357.249985002093, 5404.405515393303, 5413.621046526745, 4808.735519546432, 4892.3884514435695, 4931.630127740415, 4943.382077240345, 5096.031753966753, 4996.400431948171, 5008.2738002989545, 5036.82371117011, 5064.088464076464, 5066.0, 4651.325557794101, 4778.880527986794, 4779.139754844126, 4796.640251981098, 4922.655414121013, 4918.557329840296, 4921.704697718113, 4930.03864246472, 4965.32968049316, 5016.799328026875, 4934.333864928225, 4944.208926571731, 4982.227754697991, 4985.850424487235, 5029.0, 5258.894822103574, 5317.548008419289, 5361.463853614608, 5424.810131645373, 5431.076716958127, 5766.913496297559, 5810.389909059572, 5819.388964158787, 5841.85395365115, 5843.620164689281, 5632.07070833312, 5838.5329173666005, 5851.590388672795, 5855.648661080349, 5856.355800861902, 5293.550048245904, 5313.654612450178, 5366.6511676741275, 5421.4578542146255, 5427.972860135674, 5905.379935106838, 5906.379830117861, 5918.940810591925, 5920.052791553331, 5923.851903702356, 5525.668459892419, 5609.411011843697, 5659.26429564154, 5664.660120392789, 5667.064934285797, 5690.4025077367105, 5816.592838501264, 5819.970900145472, 5820.82537523875, 5828.79599214034, 5688.544916406678, 5726.713664316768, 5740.54075673945, 5742.655440673573, 5745.511631511285, 5590.440955904458, 5706.3152421709665, 5733.455321744427, 5746.367899531048, 5746.798862039808, 4381.496127945264, 4390.736555806662, 4394.824207031683, 4431.33529970507, 4432.069265454226, 3896.337622604164, 3915.060385507458, 3922.0979174789386, 3949.9012524686536, 3950.822213000422, 5221.66059206158, 5306.973465132727, 5445.809396671098, 5468.890622187613, 5495.505404513613, 5865.765369385177, 5887.470127688529, 5894.32215295238, 5910.083936989773, 5917.467427931507, 5560.304961879765, 5569.888602227933, 5574.442555744393, 5578.693171875586, 5579.2746942897975, 4863.562279394871, 4980.750962451935, 5005.1491246488185, 5010.799568017239, 5030.2957585938, 6009.399060094043, 6018.578699491081, 6024.307204671519, 6029.155918171459, 6029.186059881948, 5839.970800145972, 5840.0, 5840.153177789111, 5840.415958404125, 5844.15259787337, 5774.566907481872, 5929.0217114175675, 5943.316518600243, 5991.610545314541, 6034.0, 5661.037623604079, 5731.254936858349, 5731.971340143273, 5732.627379220337, 5740.913886291793, 5654.236678048411, 5825.417458254141, 5835.533157347487, 5840.065589505829, 5840.591158618856, 5596.636218645775, 5619.381867994599, 5647.237622921018, 5652.095664693629, 5663.122216056518, 5617.43825617435, 5650.886982260414, 5656.151577263443, 5656.3495198051105, 5662.462066103713, 5462.863428414322, 5547.583931205095, 5594.832155035356, 5606.971965140148, 5609.635373700697, 5629.043062679272, 5765.336986246635, 5778.248827652378, 5792.594518383841, 5797.739101740347, 5601.691906945157, 5644.745986430538, 5651.406602306699, 5654.123610840326, 5657.32112146545], "value": 5334.242957641261, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.1281928384558, 633.6388258692546, 633.8827316946363, 639.8336432527542, 652.8759535688217, 33452.66547334526, 36030.27939441209, 36047.0, 42894.14211715764, 44171.558284417224, 45383.773081134634, 45866.77066614662, 45879.99999999992, 45885.31172032414, 45969.77015114928, 8986.505742184161, 9125.72622821313, 9125.771855703593, 9131.634734610607, 9141.771455713628, 9024.77438064047, 9127.452352858816, 9133.908660913405, 9135.862962055575, 9136.63453461864, 9086.77283067922, 9151.816963660724, 9162.312826538004, 9172.0, 9172.266218702487, 9099.0, 9131.13254240846, 9139.588718507717, 9146.314026447977, 9149.5882685279, 9010.053944335881, 9077.727668169966, 9082.228010619105, 9086.318526110568, 9091.0, 43101.784491077655, 43424.78287608542, 43508.782456087836, 43537.56462435398, 43548.34677479808, 3522.295540891832, 3611.5846677632144, 3653.0, 3671.0822294426393, 3772.3398405278967, 32906.50640240398, 33230.83384583086, 33244.6675533244, 33494.49758253628, 34779.0, 4494.393256910341, 4639.188142075157, 4644.489106198315, 4727.290906364038, 4776.164171270048, 364009.17995410116, 364402.0, 368909.0, 369951.0, 370142.0, 57794.422055779745, 57871.71064144652, 58021.70989145027, 58180.41819581835, 58181.0, 35769.0, 36691.63308366935, 36695.0, 38905.610943890766, 59718.40281597216, 17371.478855634352, 17456.738148927776, 17489.82510174882, 17553.122343882755, 17565.736513952303, 13215.471381144647, 13306.800397994039, 13391.397387117602, 13399.330033498481, 13399.53101641438, 19827.900860495603, 19956.60086798285, 19962.20151193965, 20013.09941052656, 20018.399448016582, 7132.4294056475355, 7187.31720486553, 7267.963660181771, 7345.55926644403, 7364.668589913466, 961.6634178037771, 1050.6742909698019, 1075.134516714037, 1094.6442406217852, 1122.1247427006947, 33385.0, 33449.83275083609, 33568.328633427685, 33580.0, 33603.83198084043, 1137.5961533655598, 1152.9769404611861, 1176.5764324843049, 1204.602481181208, 1204.903607711381, 17466.563335916704, 17548.0, 17692.911535442498, 17705.203265853066, 17712.0, 635338.0, 636839.0, 637108.0, 638431.0, 638927.0, 58542.0, 60217.698911506035, 60304.39695603075, 60315.39684603186, 60393.396066038775, 1220.8351872497099, 1237.5297386992886, 1255.742572772561, 1352.4252192818012, 1367.7743172376645, 27013.86493067522, 35728.64271357253, 36032.63967360293, 36660.81669591635, 36715.44926826046, 55187.724061379435, 57430.0, 59061.409385905594, 59214.40785592261, 63398.36601633925, 480208.0, 481745.0, 483797.0, 486184.0, 487975.0, 36487.08782280358, 37593.81203093967, 45297.320540191264, 45672.77163614161, 45817.312740308254, 48832.0, 49039.50960490349, 49229.75385123052, 49730.25404619006, 50408.747956259984, 39823.20353592854, 41438.79280603577, 41641.79179104085, 42288.78855605702, 42379.7881010593, 40971.0, 41288.174236514504, 41782.94496875675, 42080.78959605182, 42290.0, 36567.0, 42033.0, 42412.0, 43441.0, 43446.0, 34554.481682774276, 38064.42903356507, 38141.4278785824, 38512.0, 38580.228395432496, 28661.0, 29041.0, 29080.127596172148, 29100.563491548066, 29252.268693282836], "value": 20840.622155154448, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.3598099117447, 396.24317553472855, 403.21373322022066, 410.76586345782897, 413.5285774217391, 14768.335424905878, 19075.904620476897, 20584.0, 20625.587488250243, 20631.38105856823, 18465.261389544437, 19218.519537011583, 19266.807331926677, 19830.504237394074, 20370.185192592315, 5427.728613569316, 5556.777728890839, 5557.166425036256, 5557.861053473675, 5581.581381396391, 3943.2902077626018, 5498.917516237239, 5513.972430137844, 5516.420775818541, 5539.362973258067, 5789.0, 6014.308354539218, 6066.150738896558, 6126.7855625053135, 6131.969340153293, 6064.272287325527, 6105.267367915856, 6132.601380910249, 6705.061291419205, 6710.396064354231, 5871.500922421599, 5874.97062514689, 5878.559108066912, 5896.528277737771, 5899.646021238739, 13940.721185576333, 14193.574192774233, 14197.290135493184, 14348.210848403334, 16891.0, 2362.232274510791, 2410.3853517353136, 2470.580001399748, 2542.135673870874, 2827.5193217153133, 10165.0, 10250.487475626263, 10426.270161088727, 10517.63188288414, 10851.186161037953, 1782.117851663422, 1839.5217243516647, 1937.4671965209538, 1981.4154824326858, 1989.9303524376721, 80552.59723701402, 80871.0, 81959.59020204861, 83041.58479207626, 83541.58229208815, 10452.425116618508, 10545.209109316833, 10566.207534434794, 10709.196810239264, 10799.460026998775, 14466.0, 14599.270036498345, 14616.780748288784, 14638.121712697272, 14642.0, 7991.240832121055, 8040.0, 8093.797655058553, 8155.225253600898, 8228.794280143044, 7987.520748755093, 8031.076426210943, 8053.476524025919, 8220.8355832883, 8232.917670823335, 4431.7340959542535, 4458.308962110878, 4486.237339652267, 4521.706089104197, 4612.654050946193, 1929.6623090959026, 1951.7950615185484, 1981.8909959952052, 1983.4545499987619, 2060.4333808202564, 903.290916630442, 958.3818437108026, 1033.4109557552124, 1065.9946700266605, 1090.5910283643634, 19953.900230498755, 20443.38669839907, 20487.906754713895, 20591.691124633144, 21006.15975360999, 991.5538007896475, 1000.2248257600272, 1002.0780881588955, 1034.462079718542, 1078.379931539368, 10820.56717731282, 11347.432628368548, 11447.54209831614, 11453.198276120758, 11466.713332166595, 494037.0, 494908.0, 496155.0, 496697.0, 508064.0, 92054.53972730093, 93869.53065234766, 94298.5285073584, 94847.0, 94916.0, 942.4157022646003, 961.1541843177959, 979.9759251582113, 985.1576901749045, 999.5402115027024, 17693.469195924143, 17874.46376608704, 17980.820191797913, 18191.999440030926, 18578.25686972506, 42069.36895946502, 42680.35979460248, 43087.56912430836, 43405.13189736251, 44057.0, 56266.718666408044, 56711.432885672264, 60444.69777651084, 61360.0, 61383.69308153609, 8680.78298042554, 8725.694600688945, 8742.169493898069, 8895.510746908723, 9027.593758280762, 9718.70843874685, 13632.182069075887, 13902.652433689238, 13976.860231397555, 14066.648333791738, 11019.283746556448, 11294.322340659586, 12094.879051209728, 12134.575289864812, 12297.262164269814, 10441.530131143965, 10456.37261764266, 10697.839532407175, 10954.507047183055, 11029.0, 11785.587504437304, 11987.820182697442, 12134.575289864812, 12304.876951230732, 12325.0, 8478.152184781718, 8485.0, 8595.65617375323, 8611.311095112502, 8688.218060374596, 8225.095239523767, 11264.324140551593, 12052.276863388224, 12132.0, 12185.512579497075], "value": 9176.488840983127, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.8035294705787, 1407.6199426154938, 1475.5130806833745, 1563.3199558192186, 1727.8531324837381, 8388.328933685305, 8691.087435819243, 8718.694845680402, 8957.19385255327, 8980.236679882202, 8776.341774366916, 8868.980067292263, 8877.422967507107, 8969.641214351419, 8973.057828927951, 2276.1350686739056, 2301.850379725321, 2302.3323236261463, 2303.49323148907, 2304.6888670029584, 2291.9312420627407, 2308.5382923415386, 2318.9072437102495, 2336.0655737704883, 2338.240071976606, 2212.4026512841524, 2217.2350539063996, 2237.093976939334, 2239.0819763896807, 2241.316398498457, 2158.0936006877073, 2165.0798410675557, 2195.132922495621, 2197.4067001909557, 2198.3075331270597, 2222.0667319725753, 2250.5948929192737, 2253.019936327686, 2254.6392577187735, 2256.311824893407, 8801.647934082628, 8958.820823583492, 8964.103589641049, 9019.458832470007, 9073.45559266446, 5144.6913185209005, 5249.186376111708, 5254.947450525522, 5255.421903590602, 5265.736713164365, 3215.2765627733806, 3235.3367559650214, 3245.789023713451, 3249.8050116992817, 3263.0863358259726, 1035.3994683083793, 1043.5773511727687, 1045.6131231444415, 1085.1590017736316, 1102.090775110537, 12601.810972835416, 12602.81095783564, 12661.873381266161, 12678.429470673842, 12732.172408793398, 4317.611414972667, 4343.087951530214, 4520.208963431386, 4533.954660453419, 4535.750533720677, 9825.017498250118, 9827.705168844946, 9830.508474576243, 9841.655542055994, 9845.310828241954, 5237.188235823453, 5237.842864713988, 5238.5547228486, 5240.397354304304, 5248.553872920845, 4238.258304796648, 4697.084068606658, 4869.610431165498, 4884.633652476078, 4920.581750551243, 3727.6086010968456, 3738.1028553147594, 3816.3512202925567, 3824.655780979725, 3850.2299540091535, 1116.9441527923734, 1137.221003612528, 1140.2531341971023, 1142.3716955674347, 1146.529922731676, 988.3921388346259, 1001.9499025048718, 1006.6677996261217, 1012.5089331674133, 1013.7414959185361, 5982.581219314693, 6210.689465526705, 6309.558330916791, 6357.364263573606, 6397.072424498421, 402.1554735056358, 407.58629990559604, 407.74515927545286, 413.6318676378026, 415.09095081770823, 4415.867523974286, 4428.446444194476, 4481.0, 4481.260592002283, 4491.752953587584, 10912.890871091346, 11149.331040137618, 11164.553417863357, 11213.327200368005, 11218.326900386002, 10843.51204195813, 11117.666470005914, 11120.61077862271, 11333.60332388379, 11353.148513861493, 8103.959480202561, 8217.0, 8245.381596380295, 8260.8347833043, 8321.334293256525, 6004.579679422399, 6361.0, 6375.968120159369, 6382.968085159545, 6396.0, 10485.0, 10595.09941654968, 10614.628488002883, 10622.787544248917, 10623.097036751962, 9883.30816842814, 10291.794164116825, 10298.279120461795, 10484.475776211311, 10553.736156596147, 7107.786766397016, 7329.377002954595, 7332.450066244946, 8018.679252829821, 8172.632231549714, 7423.777286681408, 7941.245581669732, 8493.150684931457, 8546.829063418822, 8736.868946965673, 7905.802354941173, 8027.719029833927, 8042.115367309474, 8048.798780030546, 8253.917460825314, 7701.4994025390415, 7740.1098873628, 7807.102183248999, 7859.52842829432, 7927.920720792949, 7371.189169191492, 7373.15208750979, 7437.330640242404, 7460.813479662835, 7533.962330188314, 5019.3976722793495, 5236.476352364885, 5237.816676416307, 5367.651102678469, 5412.43169467216, 5102.719350435762, 5172.5344718975475, 5188.9740551297, 5253.921191182212, 5362.839114826562], "value": 4530.862587477854, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.5838668118127, 328.15009126362713, 331.2331951532204, 333.49309050243613, 337.25298463902465, 5281.815136470224, 5309.380638905132, 5319.0957537218665, 5322.414534401213, 5322.654027488215, 5247.973760131194, 5248.160294352904, 5262.158244614383, 5319.707416092114, 5320.547753440953, 3945.940810887832, 4034.878953631381, 4120.175964807036, 4146.937795933063, 4152.252594532983, 4054.9391759123637, 4108.876733697994, 4112.362583799516, 4123.814428350732, 4135.214309281227, 3919.7648141111627, 4075.7758323292205, 4087.3255912774357, 4102.876913692594, 4114.847842604061, 3845.7115716321387, 4004.939925901114, 4054.493188351456, 4119.382092686121, 4143.212789569972, 3608.8736894208578, 3613.2050948791225, 3625.9456108158397, 3626.2022355082104, 3631.1466805300734, 5134.614903882224, 5137.845864624067, 5144.151215049513, 5229.267902493654, 5231.869203269911, 4590.563896429834, 4690.1557719610455, 4698.600618947394, 4713.0, 4717.339572459859, 5410.5401040911565, 5433.4566543345745, 5444.673319600836, 5458.590605704588, 5518.475744804237, 4015.6185162409524, 4019.8191081401405, 4025.818838152261, 4037.697172712029, 4042.3532234842282, 5557.41647127054, 5639.379668236491, 5696.515796157331, 5698.458646428583, 5702.517345490161, 4080.7755573443746, 4090.2024105299774, 4105.7331273467125, 4107.691923105719, 4117.444145040441, 4179.477565304337, 4181.142865712522, 4185.372194170899, 4188.350805625133, 4201.663866890642, 4451.332300154938, 4638.420197475316, 4679.298105284234, 4752.596029337545, 4764.356811830427, 5504.174373843875, 5513.669179849222, 5530.170474428868, 5531.0, 5541.889162216814, 1394.2958805803005, 1400.404827948118, 1409.4150927365029, 1412.7457057729503, 1421.3532842556613, 875.5884734175055, 881.2069137776053, 897.2194191053694, 912.7946212102356, 918.1782304837267, 5192.299039629677, 5337.251315572484, 5346.759395827197, 5352.65207761502, 5370.785168593213, 5635.506590753454, 5637.238972738628, 5650.23721797552, 5653.738504598194, 5655.208270842086, 5116.951025039858, 5331.706756128373, 5337.5463085637375, 5338.119210330329, 5417.26866872975, 2995.655499617528, 3002.714742099497, 3007.4661922419723, 3019.6829332920165, 3023.2441889527618, 5838.9124163137585, 5846.766129354864, 5858.802948894165, 5859.853503662443, 5865.266841644794, 5505.889882202334, 5784.537237021028, 5789.6104934816185, 5790.276215473066, 5830.8542286442325, 5854.151148083504, 5877.4122587740885, 5882.94107060716, 5888.322842873039, 5894.7326324839505, 5442.700651464207, 5672.9221447924765, 5691.772329106955, 5706.001449746361, 5714.457126572969, 5651.971740141273, 5660.688662123458, 5675.716214189191, 5675.914861277001, 5688.260526131577, 5826.504747096545, 5830.358660547421, 5837.744884849778, 5916.201312822714, 5926.733297001559, 3932.193900250499, 4092.7107960992194, 4100.958990410058, 4121.835126594902, 4130.896727581834, 5771.5671324649975, 5774.105013722879, 5789.623674461147, 5802.854928626818, 5826.912596310974, 5533.750981205775, 5659.54723622101, 5664.745086471036, 5681.204631351697, 5686.9715651421475, 5571.415001424792, 5583.888322233452, 5588.972055139699, 5590.580706446952, 5686.630369026, 5267.683938963674, 5443.59173062014, 5484.436935473371, 5501.614886957875, 5516.9448305518035, 5460.34475862899, 5544.946460172554, 5595.944040559705, 5599.880023995136, 5609.158626206102, 5369.140937449989, 5408.053590621704, 5415.83752487426, 5426.972865135649, 5433.918491222714], "value": 4224.854675263573, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.4959351218464, 792.805762588166, 817.9877301840473, 830.7839961609983, 862.633380813155, 14124.152550846944, 14877.851221487808, 14909.552713418587, 14976.550703478886, 14987.10077395357, 13289.933550332258, 13440.327983600806, 13442.327883605829, 13443.529476468326, 13448.327583620829, 667.072768851297, 777.4557809533321, 786.182370334851, 790.3874497264637, 800.027966021284, 810.623060276971, 810.6959890041235, 811.817341098254, 812.5774597209447, 814.9307308878723, 852.1989330029752, 854.8632218844986, 855.4396870050095, 856.5203486047802, 858.356232825381, 685.1572565744137, 816.4162623724036, 841.2092632925031, 841.3353450773882, 841.7643059943196, 612.7518355066205, 614.8678034222619, 615.0436071908181, 615.3969110271914, 616.1158737212115, 13074.084814063019, 13113.737725245537, 13151.934240328832, 13162.934185329108, 13344.733105337937, 13215.86784132156, 13373.0, 13411.329433528284, 13532.864671353258, 13942.790858137136, 12603.558875439407, 12743.171693839964, 12841.29372884491, 12887.00251461025, 12893.484260629564, 4359.564043595647, 4378.605925466723, 4471.195184866723, 4497.078098989699, 4513.796879140414, 74341.25658743452, 74590.0, 75221.62389188074, 79279.0, 80110.59944700297, 10153.0, 10353.534090965924, 10403.271770976111, 10482.959214674616, 10839.67480975572, 21118.577628447652, 21174.788252117283, 21266.78733212679, 21279.042443089787, 21356.35930922075, 8054.355651547862, 8101.270885620204, 8104.797380065427, 8118.553479558681, 8161.877571836309, 4301.677374196947, 4465.464144302705, 4509.954900451019, 4525.52481989393, 4670.439547254351, 3464.7574669772875, 3561.6260292669413, 3565.8395372208315, 3577.874774382884, 3584.444411116229, 468.9624830013591, 584.7514806207345, 585.5579037826499, 587.3451102021215, 672.4553111979312, 603.080302538632, 660.8148723154445, 748.8539734751671, 763.8625047491394, 769.707511145761, 10337.483125843828, 10365.481725913674, 10462.424566648908, 10875.51060202277, 10970.561177552809, 614.582084182751, 686.2828344380134, 699.5977313044917, 737.1854101218184, 760.8159851023485, 4813.531872778766, 5139.327220784606, 5157.561607263349, 5229.529342359206, 5269.657472264291, 129012.0, 131371.34314328368, 131478.0, 132578.33710831383, 133248.0, 109752.0, 114359.42820285846, 116032.0, 116099.0, 118084.0, 96120.0, 97445.5127724371, 97935.16189643009, 100920.49539752254, 102278.0, 9963.651272205438, 10052.899471005489, 10182.0, 10187.643432479828, 10187.643432479828, 56804.43195568157, 57505.71247143738, 58607.0, 59719.70140149445, 60897.39102609095, 83595.0, 87060.0, 88716.0, 89111.55444222737, 90396.5480172595, 13086.14940028895, 13170.473181073034, 13311.933440332736, 13481.0, 13786.448542058206, 13922.51271205503, 14149.787753183504, 14391.712165756835, 14452.2051287176, 14538.345774439964, 12892.935535322638, 12898.012121816626, 13118.0, 13244.668883277609, 13279.933600331937, 12511.56209532662, 13208.141470804367, 13572.321383930961, 13750.312484375541, 13938.30308484592, 12932.15940963872, 13104.279264640536, 13151.276679782704, 13354.86645133575, 13499.32503374847, 10063.982009413205, 10965.177611678997, 11290.43547822622, 11384.316940983568, 11633.59282425111, 11172.944135279271, 11386.544538218379, 11509.827352589886, 11555.4800033997, 11665.35840528779], "value": 7651.666545718228, "unit": "score"}], "name": "dromaeo_css", "value": 7284.660739103826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 111.0, 109.0, 112.0, 111.0, 110.0, 109.0, 109.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 119.0, 173.0, 120.0, 119.0, 144.0, 118.0, 152.0, 123.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 161.0, 160.0, 163.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 114.0, 75.0, 75.0, 74.0, 75.0, 102.0, 74.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 108.0, 84.0, 85.0, 85.0, 118.0, 84.0, 83.0, 134.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 51.0, 51.0, 50.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 63.0, 63.0, 62.0, 62.0, 64.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 78.0, 79.0, 76.0, 76.0, 75.0, 86.0, 74.0, 82.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 117.0, 116.0, 122.0, 124.0, 117.0, 119.0, 119.0, 167.0, 119.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 165.0, 158.0, 160.0, 161.0, 158.0, 159.0, 154.0, 153.0, 154.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 61.0, 61.0, 63.0, 65.0, 62.0, 62.0, 61.0, 62.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1475.2999999999997, "alertThreshold": 2.0}]} 05:37:09 INFO - Return code: 0 05:37:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:37:09 INFO - # TBPL SUCCESS # 05:37:09 INFO - Running post-action listener: _resource_record_post_action 05:37:09 INFO - ##### 05:37:09 INFO - ##### Finished run-tests step (success) 05:37:09 INFO - ##### 05:37:09 INFO - Running post-run listener: _resource_record_post_run 05:37:09 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562483200; Read time: 20; Write time: 1162392 05:37:09 INFO - TinderboxPrint: CPU usage
13.0% 05:37:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 05:37:09 INFO - TinderboxPrint: I/O write bytes / time
562,483,200 / 1,162,392 05:37:09 INFO - TinderboxPrint: CPU idle
8,271.2 (86.9%) 05:37:09 INFO - TinderboxPrint: CPU user
1,193.0 (12.5%) 05:37:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:37:09 INFO - install - Wall time: 17s; CPU: 16.0%; Read bytes: 0; Write bytes: 268312576; Read time: 0; Write time: 598248 05:37:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 290271232; Read time: 0; Write time: 563360 05:37:10 INFO - Running post-run listener: _upload_blobber_files 05:37:10 INFO - Blob upload gear active. 05:37:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:10 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 05:37:10 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'] 05:37:10 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 05:37:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:37:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:16 INFO - (blobuploader) - INFO - Done attempting. 05:37:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:17 INFO - (blobuploader) - INFO - Done attempting. 05:37:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:18 INFO - (blobuploader) - INFO - Done attempting. 05:37:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:18 INFO - Return code: 0 05:37:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c6339e799f15c66aaef77e35a28195b8ce2132b27ae06ca70deba8e4241be5250527af35e35a1ad357b954cd3b226a1773fc21d19856f46cd6a6eb1784b0b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbb1ebe1b3ed5c7fcd4dbf38871ff2112d7096c754db3996c3450ad2884e186141daf965b1845e6a7e9fe805c02d3813d6eac303a94c27eb0feed90699b6aa11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcdec88ac7f8753cf2b67a297a9ae61be3c9bb99d4e04c5c52e8c51807dcf5e7cf69459a07010aa5023893d593ed979afd74b05ebed8447dbdd45e3c8f197c4"} 05:37:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:18 INFO - Contents: 05:37:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c6339e799f15c66aaef77e35a28195b8ce2132b27ae06ca70deba8e4241be5250527af35e35a1ad357b954cd3b226a1773fc21d19856f46cd6a6eb1784b0b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbb1ebe1b3ed5c7fcd4dbf38871ff2112d7096c754db3996c3450ad2884e186141daf965b1845e6a7e9fe805c02d3813d6eac303a94c27eb0feed90699b6aa11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcdec88ac7f8753cf2b67a297a9ae61be3c9bb99d4e04c5c52e8c51807dcf5e7cf69459a07010aa5023893d593ed979afd74b05ebed8447dbdd45e3c8f197c4"} 05:37:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:18 INFO - Copying logs to upload dir... 05:37:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.656803 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-18 05:37:16.970650) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:37:16.974660) ========= 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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 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/8c6339e799f15c66aaef77e35a28195b8ce2132b27ae06ca70deba8e4241be5250527af35e35a1ad357b954cd3b226a1773fc21d19856f46cd6a6eb1784b0b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbb1ebe1b3ed5c7fcd4dbf38871ff2112d7096c754db3996c3450ad2884e186141daf965b1845e6a7e9fe805c02d3813d6eac303a94c27eb0feed90699b6aa11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcdec88ac7f8753cf2b67a297a9ae61be3c9bb99d4e04c5c52e8c51807dcf5e7cf69459a07010aa5023893d593ed979afd74b05ebed8447dbdd45e3c8f197c4"} build_url:https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/VSUP9ambSEiIH1r4JddU1A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c6339e799f15c66aaef77e35a28195b8ce2132b27ae06ca70deba8e4241be5250527af35e35a1ad357b954cd3b226a1773fc21d19856f46cd6a6eb1784b0b9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cbb1ebe1b3ed5c7fcd4dbf38871ff2112d7096c754db3996c3450ad2884e186141daf965b1845e6a7e9fe805c02d3813d6eac303a94c27eb0feed90699b6aa11", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5dcdec88ac7f8753cf2b67a297a9ae61be3c9bb99d4e04c5c52e8c51807dcf5e7cf69459a07010aa5023893d593ed979afd74b05ebed8447dbdd45e3c8f197c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 05:37:16.999460) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:37:16.999775) ========= 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=af724c981e2a0f424dbabf99000001e7-1468844201.840832-563953970 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 05:37:17.086190) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:37:17.086507) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 05:37:17.086823) ========= ========= Total master_lag: 0.17 =========