builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1452697069.91 results: success (0) buildid: 20160113060520 builduid: efdb3a18ab4d4df3beae345e3785ecab revision: d67e0c7296aa94dda34e76f6d7e256d68e7a47c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.908578) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.909049) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.909376) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006335 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.954125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.954447) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.977343) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:49.977654) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.031864) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.032171) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.032599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.032922) ========= 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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 06:57:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.0M=0s 2016-01-13 06:57:50 (74.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147283 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.205845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.206164) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020074 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.261029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.261512) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d67e0c7296aa94dda34e76f6d7e256d68e7a47c9 --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 d67e0c7296aa94dda34e76f6d7e256d68e7a47c9 --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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 06:57:50,998 truncating revision to first 12 chars 2016-01-13 06:57:50,998 Setting DEBUG logging. 2016-01-13 06:57:50,998 attempt 1/10 2016-01-13 06:57:50,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d67e0c7296aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 06:57:51,281 unpacking tar archive at: fx-team-d67e0c7296aa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.609153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.887604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.887959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.902111) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.902463) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 06:57:50.902921) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 29 secs) (at 2016-01-13 06:57:50.903263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:51 INFO - MultiFileLogger online at 20160113 06:57:51 in /builds/slave/test 06:57:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:57:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:51 INFO - {'append_to_log': False, 06:57:51 INFO - 'base_work_dir': '/builds/slave/test', 06:57:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:57:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:51 INFO - 'branch': 'Fx-Team-Non-PGO', 06:57:51 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:51 INFO - 'config_files': ('talos/linux_config.py',), 06:57:51 INFO - 'default_actions': ('clobber', 06:57:51 INFO - 'read-buildbot-config', 06:57:51 INFO - 'download-and-extract', 06:57:51 INFO - 'populate-webroot', 06:57:51 INFO - 'create-virtualenv', 06:57:51 INFO - 'install', 06:57:51 INFO - 'run-tests'), 06:57:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:51 INFO - 'download_minidump_stackwalk': True, 06:57:51 INFO - 'download_symbols': 'ondemand', 06:57:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:51 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:51 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:51 INFO - 'installer_path': 'installer.exe', 06:57:51 INFO - 'log_level': 'info', 06:57:51 INFO - 'log_name': 'talos', 06:57:51 INFO - 'log_to_console': True, 06:57:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:51 INFO - 'opt_config_files': (), 06:57:51 INFO - 'pip_index': False, 06:57:51 INFO - 'sps_profile': False, 06:57:51 INFO - 'sps_profile_interval': 0, 06:57:51 INFO - 'suite': 'dromaeojs', 06:57:51 INFO - 'system_bits': '32', 06:57:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:51 INFO - 'title': 'talos-linux64-ix-058', 06:57:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:51 INFO - 'use_talos_json': True, 06:57:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:51 INFO - 'work_dir': 'build'} 06:57:51 INFO - ##### 06:57:51 INFO - ##### Running clobber step. 06:57:51 INFO - ##### 06:57:51 INFO - Running pre-action listener: _resource_record_pre_action 06:57:51 INFO - Running main action method: clobber 06:57:51 INFO - rmtree: /builds/slave/test/build 06:57:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:52 INFO - Running post-action listener: _resource_record_post_action 06:57:52 INFO - ##### 06:57:52 INFO - ##### Running read-buildbot-config step. 06:57:52 INFO - ##### 06:57:52 INFO - Running pre-action listener: _resource_record_pre_action 06:57:52 INFO - Running main action method: read_buildbot_config 06:57:52 INFO - Using buildbot properties: 06:57:52 INFO - { 06:57:52 INFO - "project": "", 06:57:52 INFO - "product": "firefox", 06:57:52 INFO - "script_repo_revision": "production", 06:57:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:57:52 INFO - "repository": "", 06:57:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:57:52 INFO - "buildid": "20160113060520", 06:57:52 INFO - "pgo_build": "False", 06:57:52 INFO - "basedir": "/builds/slave/test", 06:57:52 INFO - "buildnumber": 1230, 06:57:52 INFO - "slavename": "talos-linux64-ix-058", 06:57:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:52 INFO - "platform": "ubuntu64_hw", 06:57:52 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:57:52 INFO - "branch": "fx-team", 06:57:52 INFO - "repo_path": "integration/fx-team", 06:57:52 INFO - "revision": "d67e0c7296aa94dda34e76f6d7e256d68e7a47c9", 06:57:52 INFO - "stage_platform": "linux64", 06:57:52 INFO - "builduid": "efdb3a18ab4d4df3beae345e3785ecab", 06:57:52 INFO - "slavebuilddir": "test" 06:57:52 INFO - } 06:57:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 06:57:52 INFO - Running post-action listener: _resource_record_post_action 06:57:52 INFO - ##### 06:57:52 INFO - ##### Running download-and-extract step. 06:57:52 INFO - ##### 06:57:52 INFO - Running pre-action listener: _resource_record_pre_action 06:57:52 INFO - Running main action method: download_and_extract 06:57:52 INFO - mkdir: /builds/slave/test/build/tests 06:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:57:52 INFO - https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:57:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/test_packages.json 06:57:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/test_packages.json 06:57:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:57:56 INFO - Downloaded 1448 bytes. 06:57:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:57:56 INFO - Using the following test package requirements: 06:57:56 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:56 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:56 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:57:56 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'jsshell-linux-x86_64.zip'], 06:57:56 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:56 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:56 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:56 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:56 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:56 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:56 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:56 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:56 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 06:57:56 INFO - https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:59:26 INFO - Downloaded 22760804 bytes. 06:59:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:59:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:59:26 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:59:27 INFO - Return code: 0 06:59:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:59:27 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')]} 06:59:27 INFO - https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:59:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:59:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:59:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 06:59:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:01:09 INFO - Downloaded 22760804 bytes. 07:01:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 07:01:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:01:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 07:01:10 INFO - Return code: 0 07:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:01:10 INFO - https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:01:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:02:04 INFO - Downloaded 11132279 bytes. 07:02:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 07:02:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:02:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 07:02:04 INFO - Return code: 0 07:02:04 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')]} 07:02:04 INFO - https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:03:18 INFO - Downloaded 53908459 bytes. 07:03:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:03:18 INFO - mkdir: /builds/slave/test/properties 07:03:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:03:18 INFO - Writing to file /builds/slave/test/properties/build_url 07:03:18 INFO - Contents: 07:03:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:03:18 INFO - Running post-action listener: _resource_record_post_action 07:03:18 INFO - Running post-action listener: set_extra_try_arguments 07:03:18 INFO - ##### 07:03:18 INFO - ##### Running populate-webroot step. 07:03:18 INFO - ##### 07:03:18 INFO - Running pre-action listener: _resource_record_pre_action 07:03:18 INFO - Running main action method: populate_webroot 07:03:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:03:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:03:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:03:18 INFO - '--tppagecycles', 07:03:18 INFO - '7'], 07:03:18 INFO - 'tests': ['tsvgm']}}, 07:03:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:03:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:03:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:03:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:03:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:03:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'tests': ['damp', 'tps']}, 07:03:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['damp', 'tps']}, 07:03:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:03:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:03:18 INFO - 'other': {'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'other_l64': {'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'other_nol64': {'tests': ['a11yr', 07:03:18 INFO - 'ts_paint', 07:03:18 INFO - 'tpaint', 07:03:18 INFO - 'sessionrestore', 07:03:18 INFO - 'sessionrestore_no_auto_restore']}, 07:03:18 INFO - 'svgr': {'tests': ['tsvgx', 07:03:18 INFO - 'tsvgr_opacity', 07:03:18 INFO - 'tart', 07:03:18 INFO - 'tscrollx', 07:03:18 INFO - 'cart']}, 07:03:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['tsvgx', 07:03:18 INFO - 'tsvgr_opacity', 07:03:18 INFO - 'tart', 07:03:18 INFO - 'tscrollx', 07:03:18 INFO - 'cart']}, 07:03:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'tests': ['tp5o']}, 07:03:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'talos_options': ['--e10s'], 07:03:18 INFO - 'tests': ['tp5o']}, 07:03:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'talos_options': ['--xperf_path', 07:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:18 INFO - 'tests': ['tp5n']}, 07:03:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:03:18 INFO - 'talos_options': ['--e10s', 07:03:18 INFO - '--xperf_path', 07:03:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:03:18 INFO - 'tests': ['tp5n']}}, 07:03:18 INFO - 'talos.zip': {'path': '', 07:03:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:03:18 INFO - Running post-action listener: _resource_record_post_action 07:03:18 INFO - ##### 07:03:18 INFO - ##### Running create-virtualenv step. 07:03:18 INFO - ##### 07:03:18 INFO - Running pre-action listener: _resource_record_pre_action 07:03:18 INFO - Running main action method: create_virtualenv 07:03:18 INFO - Creating virtualenv /builds/slave/test/build/venv 07:03:18 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 07:03:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:03:19 INFO - Using real prefix '/usr' 07:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:03:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:03:21 INFO - Installing pip.................done. 07:03:21 INFO - Return code: 0 07:03:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:03:21 INFO - Using env: {'DISPLAY': ':0', 07:03:21 INFO - 'HOME': '/home/cltbld', 07:03:21 INFO - 'LANG': 'en_US.UTF-8', 07:03:21 INFO - 'LANGUAGE': 'en_US:en', 07:03:21 INFO - 'LOGNAME': 'cltbld', 07:03:21 INFO - 'MAIL': '/var/mail/cltbld', 07:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:21 INFO - 'MOZ_NO_REMOTE': '1', 07:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:21 INFO - 'NO_EM_RESTART': '1', 07:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:21 INFO - 'PWD': '/builds/slave/test', 07:03:21 INFO - 'SHELL': '/bin/bash', 07:03:21 INFO - 'SHLVL': '1', 07:03:21 INFO - 'TERM': 'linux', 07:03:21 INFO - 'TMOUT': '86400', 07:03:21 INFO - 'USER': 'cltbld', 07:03:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:21 INFO - '_': '/tools/buildbot/bin/python'} 07:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:21 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 07:03:21 INFO - Cleaning up... 07:03:21 INFO - Return code: 0 07:03:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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>=0.7.1'] in /builds/slave/test/build 07:03:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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>=0.7.1 07:03:21 INFO - Using env: {'DISPLAY': ':0', 07:03:21 INFO - 'HOME': '/home/cltbld', 07:03:21 INFO - 'LANG': 'en_US.UTF-8', 07:03:21 INFO - 'LANGUAGE': 'en_US:en', 07:03:21 INFO - 'LOGNAME': 'cltbld', 07:03:21 INFO - 'MAIL': '/var/mail/cltbld', 07:03:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:21 INFO - 'MOZ_NO_REMOTE': '1', 07:03:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:21 INFO - 'NO_EM_RESTART': '1', 07:03:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:21 INFO - 'PWD': '/builds/slave/test', 07:03:21 INFO - 'SHELL': '/bin/bash', 07:03:21 INFO - 'SHLVL': '1', 07:03:21 INFO - 'TERM': 'linux', 07:03:21 INFO - 'TMOUT': '86400', 07:03:21 INFO - 'USER': 'cltbld', 07:03:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:21 INFO - '_': '/tools/buildbot/bin/python'} 07:03:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:21 INFO - Downloading/unpacking psutil>=0.7.1 07:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:23 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:03:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:23 INFO - Installing collected packages: psutil 07:03:23 INFO - Running setup.py install for psutil 07:03:23 INFO - building 'psutil._psutil_linux' extension 07:03:23 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 07:03:24 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 07:03:24 INFO - building 'psutil._psutil_posix' extension 07:03:24 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 07:03:24 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 07:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:03:24 INFO - Successfully installed psutil 07:03:24 INFO - Cleaning up... 07:03:24 INFO - Return code: 0 07:03:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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.0.0'] in /builds/slave/test/build 07:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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.0.0 07:03:24 INFO - Using env: {'DISPLAY': ':0', 07:03:24 INFO - 'HOME': '/home/cltbld', 07:03:24 INFO - 'LANG': 'en_US.UTF-8', 07:03:24 INFO - 'LANGUAGE': 'en_US:en', 07:03:24 INFO - 'LOGNAME': 'cltbld', 07:03:24 INFO - 'MAIL': '/var/mail/cltbld', 07:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:24 INFO - 'MOZ_NO_REMOTE': '1', 07:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:24 INFO - 'NO_EM_RESTART': '1', 07:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:24 INFO - 'PWD': '/builds/slave/test', 07:03:24 INFO - 'SHELL': '/bin/bash', 07:03:24 INFO - 'SHLVL': '1', 07:03:24 INFO - 'TERM': 'linux', 07:03:24 INFO - 'TMOUT': '86400', 07:03:24 INFO - 'USER': 'cltbld', 07:03:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:24 INFO - '_': '/tools/buildbot/bin/python'} 07:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:03:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:03:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:03:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:03:26 INFO - Installing collected packages: mozsystemmonitor 07:03:26 INFO - Running setup.py install for mozsystemmonitor 07:03:26 INFO - Successfully installed mozsystemmonitor 07:03:26 INFO - Cleaning up... 07:03:26 INFO - Return code: 0 07:03:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:03:26 INFO - Using env: {'DISPLAY': ':0', 07:03:26 INFO - 'HOME': '/home/cltbld', 07:03:26 INFO - 'LANG': 'en_US.UTF-8', 07:03:26 INFO - 'LANGUAGE': 'en_US:en', 07:03:26 INFO - 'LOGNAME': 'cltbld', 07:03:26 INFO - 'MAIL': '/var/mail/cltbld', 07:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:26 INFO - 'MOZ_NO_REMOTE': '1', 07:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:26 INFO - 'NO_EM_RESTART': '1', 07:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:26 INFO - 'PWD': '/builds/slave/test', 07:03:26 INFO - 'SHELL': '/bin/bash', 07:03:26 INFO - 'SHLVL': '1', 07:03:26 INFO - 'TERM': 'linux', 07:03:26 INFO - 'TMOUT': '86400', 07:03:26 INFO - 'USER': 'cltbld', 07:03:26 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:26 INFO - '_': '/tools/buildbot/bin/python'} 07:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:03:26 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 07:03:26 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 07:03:26 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 07:03:26 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 07:03:26 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 07:03:26 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 07:03:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:03:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:03:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:03:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:03:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:28 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 07:03:29 INFO - Downloading docopt-0.6.1.tar.gz 07:03:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:03:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:03:29 INFO - Running setup.py install for blobuploader 07:03:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:03:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:03:29 INFO - Running setup.py install for requests 07:03:29 INFO - Running setup.py install for docopt 07:03:29 INFO - Successfully installed blobuploader requests docopt 07:03:29 INFO - Cleaning up... 07:03:29 INFO - Return code: 0 07:03:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:29 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')]} 07:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:29 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')]} 07:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 07:03:29 INFO - Using env: {'DISPLAY': ':0', 07:03:29 INFO - 'HOME': '/home/cltbld', 07:03:29 INFO - 'LANG': 'en_US.UTF-8', 07:03:29 INFO - 'LANGUAGE': 'en_US:en', 07:03:29 INFO - 'LOGNAME': 'cltbld', 07:03:29 INFO - 'MAIL': '/var/mail/cltbld', 07:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:29 INFO - 'MOZ_NO_REMOTE': '1', 07:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:29 INFO - 'NO_EM_RESTART': '1', 07:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:29 INFO - 'PWD': '/builds/slave/test', 07:03:29 INFO - 'SHELL': '/bin/bash', 07:03:29 INFO - 'SHLVL': '1', 07:03:29 INFO - 'TERM': 'linux', 07:03:29 INFO - 'TMOUT': '86400', 07:03:29 INFO - 'USER': 'cltbld', 07:03:29 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:29 INFO - '_': '/tools/buildbot/bin/python'} 07:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:29 INFO - Running setup.py (path:/tmp/pip-qjg1IV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:30 INFO - Running setup.py (path:/tmp/pip-qjf5zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:30 INFO - Running setup.py (path:/tmp/pip-n8kJpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:30 INFO - Running setup.py (path:/tmp/pip-q2HjU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:30 INFO - Running setup.py (path:/tmp/pip-eVJg_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:30 INFO - Running setup.py (path:/tmp/pip-UFzEKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:30 INFO - Running setup.py (path:/tmp/pip-iPARiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:30 INFO - Running setup.py (path:/tmp/pip-yuZwfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:30 INFO - Running setup.py (path:/tmp/pip-UqKrUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:30 INFO - Running setup.py (path:/tmp/pip-4nY0xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:30 INFO - Running setup.py (path:/tmp/pip-1lVavx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:30 INFO - Running setup.py (path:/tmp/pip-3Y1cR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:30 INFO - Running setup.py (path:/tmp/pip-iNSmi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:30 INFO - Running setup.py (path:/tmp/pip-3vZSO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:30 INFO - Running setup.py (path:/tmp/pip-YDGDcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:31 INFO - Running setup.py (path:/tmp/pip-yxv83z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:31 INFO - Running setup.py (path:/tmp/pip-wa8SSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:03:31 INFO - Running setup.py install for manifestparser 07:03:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Running setup.py install for mozcrash 07:03:31 INFO - Running setup.py install for mozdebug 07:03:31 INFO - Running setup.py install for mozdevice 07:03:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Running setup.py install for mozfile 07:03:31 INFO - Running setup.py install for mozhttpd 07:03:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Running setup.py install for mozinfo 07:03:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Running setup.py install for mozInstall 07:03:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:03:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Running setup.py install for mozleak 07:03:32 INFO - Running setup.py install for mozlog 07:03:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Running setup.py install for moznetwork 07:03:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Running setup.py install for mozprocess 07:03:32 INFO - Running setup.py install for mozprofile 07:03:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Running setup.py install for mozrunner 07:03:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Running setup.py install for mozscreenshot 07:03:32 INFO - Running setup.py install for moztest 07:03:32 INFO - Running setup.py install for mozversion 07:03:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:03:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:03:32 INFO - Cleaning up... 07:03:32 INFO - Return code: 0 07:03:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:03:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:03:32 INFO - Using env: {'DISPLAY': ':0', 07:03:32 INFO - 'HOME': '/home/cltbld', 07:03:32 INFO - 'LANG': 'en_US.UTF-8', 07:03:32 INFO - 'LANGUAGE': 'en_US:en', 07:03:32 INFO - 'LOGNAME': 'cltbld', 07:03:32 INFO - 'MAIL': '/var/mail/cltbld', 07:03:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:32 INFO - 'MOZ_NO_REMOTE': '1', 07:03:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:32 INFO - 'NO_EM_RESTART': '1', 07:03:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:32 INFO - 'PWD': '/builds/slave/test', 07:03:32 INFO - 'SHELL': '/bin/bash', 07:03:32 INFO - 'SHLVL': '1', 07:03:32 INFO - 'TERM': 'linux', 07:03:32 INFO - 'TMOUT': '86400', 07:03:32 INFO - 'USER': 'cltbld', 07:03:32 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:32 INFO - '_': '/tools/buildbot/bin/python'} 07:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:03:33 INFO - Running setup.py (path:/tmp/pip-mEzjOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:03:33 INFO - Running setup.py (path:/tmp/pip-GRP6wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:03:33 INFO - Running setup.py (path:/tmp/pip-GGuJA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:03:33 INFO - Running setup.py (path:/tmp/pip-tvStBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:03:33 INFO - Running setup.py (path:/tmp/pip-TraZbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:03:33 INFO - Running setup.py (path:/tmp/pip-WTpm3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:03:33 INFO - Running setup.py (path:/tmp/pip-xF5aKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:03:33 INFO - Running setup.py (path:/tmp/pip-SKcogs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:03:33 INFO - Running setup.py (path:/tmp/pip-1GbSiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:03:33 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:03:33 INFO - Running setup.py (path:/tmp/pip-p8xAhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 07:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:03:33 INFO - Running setup.py (path:/tmp/pip-MIwCZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:03:34 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:03:34 INFO - Running setup.py (path:/tmp/pip-9xLA7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:03:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:03:34 INFO - Running setup.py (path:/tmp/pip-HUbC2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:03:34 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:03:34 INFO - Running setup.py (path:/tmp/pip-6gAbNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:03:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:34 INFO - Running setup.py (path:/tmp/pip-ulHDoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:03:34 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:03:34 INFO - Running setup.py (path:/tmp/pip-90beQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:03:34 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)) 07:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:03:34 INFO - Running setup.py (path:/tmp/pip-BeUjLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:03:34 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)) 07:03:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:34 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:03:34 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)) 07:03:34 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)) 07:03:34 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)) 07:03:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:03:34 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 07:03:34 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 07:03:34 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 07:03:34 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 07:03:34 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 07:03:34 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 07:03:36 INFO - Downloading blessings-1.5.1.tar.gz 07:03:36 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 07:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:03:36 INFO - Installing collected packages: blessings 07:03:36 INFO - Running setup.py install for blessings 07:03:36 INFO - Successfully installed blessings 07:03:36 INFO - Cleaning up... 07:03:36 INFO - Return code: 0 07:03:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:36 INFO - Reading from file tmpfile_stdout 07:03:36 INFO - Current package versions: 07:03:36 INFO - argparse == 1.2.1 07:03:36 INFO - blessings == 1.5.1 07:03:36 INFO - blobuploader == 1.2.4 07:03:36 INFO - docopt == 0.6.1 07:03:36 INFO - manifestparser == 1.1 07:03:36 INFO - mozInstall == 1.12 07:03:36 INFO - mozcrash == 0.16 07:03:36 INFO - mozdebug == 0.1 07:03:36 INFO - mozdevice == 0.48 07:03:36 INFO - mozfile == 1.2 07:03:36 INFO - mozhttpd == 0.7 07:03:36 INFO - mozinfo == 0.9 07:03:36 INFO - mozleak == 0.1 07:03:36 INFO - mozlog == 3.1 07:03:36 INFO - moznetwork == 0.27 07:03:36 INFO - mozprocess == 0.22 07:03:36 INFO - mozprofile == 0.28 07:03:36 INFO - mozrunner == 6.11 07:03:36 INFO - mozscreenshot == 0.1 07:03:36 INFO - mozsystemmonitor == 0.0 07:03:36 INFO - moztest == 0.7 07:03:36 INFO - mozversion == 1.4 07:03:36 INFO - psutil == 3.1.1 07:03:36 INFO - requests == 1.2.3 07:03:36 INFO - wsgiref == 0.1.2 07:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:03:36 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')]} 07:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:36 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')]} 07:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:03:36 INFO - Using env: {'DISPLAY': ':0', 07:03:36 INFO - 'HOME': '/home/cltbld', 07:03:36 INFO - 'LANG': 'en_US.UTF-8', 07:03:36 INFO - 'LANGUAGE': 'en_US:en', 07:03:36 INFO - 'LOGNAME': 'cltbld', 07:03:36 INFO - 'MAIL': '/var/mail/cltbld', 07:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:36 INFO - 'MOZ_NO_REMOTE': '1', 07:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:36 INFO - 'NO_EM_RESTART': '1', 07:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:36 INFO - 'PWD': '/builds/slave/test', 07:03:36 INFO - 'SHELL': '/bin/bash', 07:03:36 INFO - 'SHLVL': '1', 07:03:36 INFO - 'TERM': 'linux', 07:03:36 INFO - 'TMOUT': '86400', 07:03:36 INFO - 'USER': 'cltbld', 07:03:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:36 INFO - '_': '/tools/buildbot/bin/python'} 07:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 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)) 07:03:36 INFO - Cleaning up... 07:03:36 INFO - Return code: 0 07:03:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:03:36 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')]} 07:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:36 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')]} 07:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 07:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 07:03:36 INFO - Using env: {'DISPLAY': ':0', 07:03:36 INFO - 'HOME': '/home/cltbld', 07:03:36 INFO - 'LANG': 'en_US.UTF-8', 07:03:36 INFO - 'LANGUAGE': 'en_US:en', 07:03:36 INFO - 'LOGNAME': 'cltbld', 07:03:36 INFO - 'MAIL': '/var/mail/cltbld', 07:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:36 INFO - 'MOZ_NO_REMOTE': '1', 07:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:36 INFO - 'NO_EM_RESTART': '1', 07:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:36 INFO - 'PWD': '/builds/slave/test', 07:03:36 INFO - 'SHELL': '/bin/bash', 07:03:36 INFO - 'SHLVL': '1', 07:03:36 INFO - 'TERM': 'linux', 07:03:36 INFO - 'TMOUT': '86400', 07:03:36 INFO - 'USER': 'cltbld', 07:03:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:36 INFO - '_': '/tools/buildbot/bin/python'} 07:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:37 INFO - Downloading/unpacking jsonschema 07:03:37 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 07:03:37 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 07:03:37 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 07:03:37 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 07:03:37 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 07:03:37 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 07:03:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:03:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 07:03:38 INFO - Downloading/unpacking functools32 (from jsonschema) 07:03:38 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 07:03:38 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 07:03:38 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 07:03:38 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 07:03:38 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 07:03:38 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 07:03:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:03:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:03:39 INFO - warning: no files found matching '*.txt' 07:03:39 INFO - no previously-included directories found matching 'build' 07:03:39 INFO - no previously-included directories found matching 'dist' 07:03:39 INFO - no previously-included directories found matching '.git*' 07:03:39 INFO - Installing collected packages: jsonschema, functools32 07:03:39 INFO - Running setup.py install for functools32 07:03:39 INFO - warning: no files found matching '*.txt' 07:03:39 INFO - no previously-included directories found matching 'build' 07:03:39 INFO - no previously-included directories found matching 'dist' 07:03:39 INFO - no previously-included directories found matching '.git*' 07:03:39 INFO - Successfully installed jsonschema functools32 07:03:39 INFO - Cleaning up... 07:03:39 INFO - Return code: 0 07:03:39 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:03:39 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')]} 07:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 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')]} 07:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:03:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfe4345f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26718a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2740dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, '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': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', '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 07:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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', 'flake8'] in /builds/slave/test/build 07:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 flake8 07:03:39 INFO - Using env: {'DISPLAY': ':0', 07:03:39 INFO - 'HOME': '/home/cltbld', 07:03:39 INFO - 'LANG': 'en_US.UTF-8', 07:03:39 INFO - 'LANGUAGE': 'en_US:en', 07:03:39 INFO - 'LOGNAME': 'cltbld', 07:03:39 INFO - 'MAIL': '/var/mail/cltbld', 07:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:39 INFO - 'MOZ_NO_REMOTE': '1', 07:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:39 INFO - 'NO_EM_RESTART': '1', 07:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:39 INFO - 'PWD': '/builds/slave/test', 07:03:39 INFO - 'SHELL': '/bin/bash', 07:03:39 INFO - 'SHLVL': '1', 07:03:39 INFO - 'TERM': 'linux', 07:03:39 INFO - 'TMOUT': '86400', 07:03:39 INFO - 'USER': 'cltbld', 07:03:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:39 INFO - '_': '/tools/buildbot/bin/python'} 07:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:03:39 INFO - Downloading/unpacking flake8 07:03:39 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 07:03:39 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 07:03:39 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 07:03:39 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 07:03:39 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 07:03:39 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 07:03:41 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:03:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:03:41 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:03:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:03:41 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:03:41 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 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 07:03:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:03:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:03:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:03:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:03:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:03:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:03:41 INFO - no previously-included directories found matching 'docs/_build' 07:03:41 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:03:41 INFO - Running setup.py install for pep8 07:03:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:03:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:03:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:03:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:03:41 INFO - no previously-included directories found matching 'docs/_build' 07:03:42 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:03:42 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:03:42 INFO - Cleaning up... 07:03:42 INFO - Return code: 0 07:03:42 INFO - Running post-action listener: _resource_record_post_action 07:03:42 INFO - Running post-action listener: _start_resource_monitoring 07:03:42 INFO - Starting resource monitoring. 07:03:42 INFO - ##### 07:03:42 INFO - ##### Running install step. 07:03:42 INFO - ##### 07:03:42 INFO - Running pre-action listener: _resource_record_pre_action 07:03:42 INFO - Running main action method: install 07:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:03:42 INFO - Reading from file tmpfile_stdout 07:03:42 INFO - Detecting whether we're running mozinstall >=1.0... 07:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:03:42 INFO - Reading from file tmpfile_stdout 07:03:42 INFO - Output received: 07:03:42 INFO - Usage: mozinstall [options] installer 07:03:42 INFO - Options: 07:03:42 INFO - -h, --help show this help message and exit 07:03:42 INFO - -d DEST, --destination=DEST 07:03:42 INFO - Directory to install application into. [default: 07:03:42 INFO - "/builds/slave/test"] 07:03:42 INFO - --app=APP Application being installed. [default: firefox] 07:03:42 INFO - mkdir: /builds/slave/test/build/application 07:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:03:58 INFO - Reading from file tmpfile_stdout 07:03:58 INFO - Output received: 07:03:58 INFO - /builds/slave/test/build/application/firefox/firefox 07:03:58 INFO - Running post-action listener: _resource_record_post_action 07:03:58 INFO - ##### 07:03:58 INFO - ##### Running run-tests step. 07:03:58 INFO - ##### 07:03:58 INFO - Running pre-action listener: _resource_record_pre_action 07:03:58 INFO - Running main action method: run_tests 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:03:58 INFO - Python 2.7.3 07:03:58 INFO - Return code: 0 07:03:58 INFO - grabbing minidump binary from tooltool 07:03: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')]} 07:03:58 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27d33d0>, '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 0x273eed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273f360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:03:58 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 07:03:58 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 07:03:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:03:58 INFO - Return code: 0 07:03:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:03:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:03:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:03:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:03:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:03:59 INFO - Return code: 0 07:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 07:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 07:03:59 INFO - Using env: {'DISPLAY': ':0', 07:03:59 INFO - 'HOME': '/home/cltbld', 07:03:59 INFO - 'LANG': 'en_US.UTF-8', 07:03:59 INFO - 'LANGUAGE': 'en_US:en', 07:03:59 INFO - 'LOGNAME': 'cltbld', 07:03:59 INFO - 'MAIL': '/var/mail/cltbld', 07:03:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:03:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:03:59 INFO - 'MOZ_NO_REMOTE': '1', 07:03:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:03:59 INFO - 'NO_EM_RESTART': '1', 07:03:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:03:59 INFO - 'PWD': '/builds/slave/test', 07:03:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:03:59 INFO - 'SHELL': '/bin/bash', 07:03:59 INFO - 'SHLVL': '1', 07:03:59 INFO - 'TERM': 'linux', 07:03:59 INFO - 'TMOUT': '86400', 07:03:59 INFO - 'USER': 'cltbld', 07:03:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383', 07:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:03:59 INFO - '_': '/tools/buildbot/bin/python'} 07:03:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 07:03:59 INFO - mozversion application_buildid: 20160113060520 07:03:59 INFO - mozversion application_changeset: d67e0c7296aa94dda34e76f6d7e256d68e7a47c9 07:03:59 INFO - mozversion application_display_name: Nightly 07:03:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:03:59 INFO - mozversion application_name: Firefox 07:03:59 INFO - mozversion application_remotingname: firefox 07:03:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:03:59 INFO - mozversion application_vendor: Mozilla 07:03:59 INFO - mozversion application_version: 46.0a1 07:03:59 INFO - mozversion platform_buildid: 20160113060520 07:03:59 INFO - mozversion platform_changeset: d67e0c7296aa94dda34e76f6d7e256d68e7a47c9 07:03:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:03:59 INFO - mozversion platform_version: 46.0a1 07:03:59 INFO - using testdate: 1452697439 07:03:59 INFO - actual date: 1452697439 07:03:59 INFO - starting webserver on 'localhost:50154' 07:03:59 INFO - SUITE-START | Running 3 tests 07:03:59 INFO - TEST-START | dromaeo_css 07:03:59 INFO - operating with platform_type : linux_ 07:03:59 INFO - Initialising browser for dromaeo_css test... 07:03:59 INFO - TEST-INFO | started process 16778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_QxOX0/profile http://localhost:50154/getInfo.html) 07:04:03 INFO - PROCESS | 16778 | __metrics Screen width/height:1600/1200 07:04:03 INFO - PROCESS | 16778 | colorDepth:24 07:04:03 INFO - PROCESS | 16778 | Browser inner width/height: 1024/697 07:04:03 INFO - PROCESS | 16778 | __metrics 07:04:03 INFO - PROCESS | 16778 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:04:03 INFO - PROCESS | 16778 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:04:04 INFO - TEST-INFO | 16778: exit 0 07:04:04 INFO - Browser initialized. 07:04:04 INFO - Running cycle 1/1 for dromaeo_css test... 07:04:04 INFO - TEST-INFO | started process 16868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_QxOX0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:04:16 INFO - PROCESS | 16868 | RSS: Main: 150712320 07:04:16 INFO - PROCESS | 16868 | 07:05:07 INFO - PROCESS | 16868 | 1452697507895 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] 07:07:19 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50154/tests/dromaeo/cssquery-ext.html) 07:07:20 INFO - PROCESS | 16868 | RSS: Main: 249024512 07:07:20 INFO - PROCESS | 16868 | 07:10:23 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-ext.html (next: http://localhost:50154/tests/dromaeo/cssquery-jquery.html) 07:10:23 INFO - PROCESS | 16868 | RSS: Main: 230600704 07:10:23 INFO - PROCESS | 16868 | 07:13:25 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50154/tests/dromaeo/cssquery-mootools.html) 07:13:26 INFO - PROCESS | 16868 | RSS: Main: 230887424 07:13:26 INFO - PROCESS | 16868 | 07:16:28 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50154/tests/dromaeo/cssquery-prototype.html) 07:16:28 INFO - PROCESS | 16868 | RSS: Main: 212336640 07:16:28 INFO - PROCESS | 16868 | 07:19:31 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50154/tests/dromaeo/cssquery-yui.html) 07:19:32 INFO - PROCESS | 16868 | RSS: Main: 187174912 07:19:32 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | Cycle 1(1): loaded http://localhost:50154/tests/dromaeo/cssquery-yui.html (next: http://localhost:50154/tests/dromaeo/cssquery-dojo.html) 07:22:34 INFO - PROCESS | 16868 | RSS: Main: 258154496 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | __start_tp_report 07:22:34 INFO - PROCESS | 16868 | _x_x_mozilla_page_load 07:22:34 INFO - PROCESS | 16868 | _x_x_mozilla_page_load_details 07:22:34 INFO - PROCESS | 16868 | |i|pagename|runs| 07:22:34 INFO - PROCESS | 16868 | |0;dojo.html;2564.141012760725;2601.791856651468;2603.1930101668495;2617.7251388604195;2630.9999999999995;4310.310350343945;4342.978285108574;4345.413369195162;4362.563743625636;4385.2764293891505;4388.429504164455;4398.736075835444;4403.977980110103;4416.801243944023;4457.910841783162;4102.97948510257;4119.382092686091;4129.938050929239;4136.4415803866395;4146.481689788777;4180.519240287375;4235.110626768383;4257.723247988871;4260.211860805761;4265.552117027699;3989.880303590897;4032.334664780308;4056.411820286042;4059.3099173140636;4064.9390259146135;4094.815733291979;4114.506259248909;4121.340585506335;4135.958640413587;4160.667146628262;4064.2074795414906;4084.6732261419015;4099.241640296555;4119.8352065917325;4128.731632443882;4312.568743125694;4376.518582955872;4392.38506609075;4393.824247030115;4396.120775844844;4687.531246875319;4697.8355757548325;4709.340692303081;4770.212914869043;4770.356001939728;4747.572718455355;4752.833650822205;4757.3815403997605;4788.784504697297;4796.616270698336;4332.241857674926;4411.713238639478;4414.359917811899;4439.334099884978;4439.622632076277;4827.08285425768;4830.589399900978;4831.057943701015;4853.9029219416125;4875.804967801319;4630.6063984561015;4643.164230438553;4644.140833945731;4648.279516674921;4676.719396836201;4655.045715628288;4711.293306004059;4718.7168769873915;4730.62155027597;4772.809087636456;4657.510961349078;4676.976615116902;4683.695559788603;4693.718376897329;4729.763511824395;4634.559716826896;4635.281531362644;4635.420572428447;4649.883752906205;4681.133990211822;3923.1172986077904;3970.781607011584;3974.324364857981;3994.580569040267;4012.658923991435;3516.841742121611;3526.5239192708655;3537.451694987281;3564.7326450515798;3586.533750612456;4078.877633670995;4099.959000410017;4110.375253904025;4114.547399786021;4169.708120431601;4624.1445332613575;4693.647976401783;4700.177468942921;4735.550122738335;4776.2119250324;4132.524759652679;4174.352975288835;4175.10235299406;4197.3074442717225;4217.388478670576;4185.874423767292;4232.153569286155;4236.5128010278595;4242.045539753531;4295.162443323585;4362.672799540111;4448.154850578379;4462.799174037111;4509.977450112794;4510.819567217274;4724.881877953078;4755.2153894607;4757.429108507002;4764.49972752856;4826.903461930812;4494.415725955605;4512.571305725951;4515.1195516873895;4516.7289962601035;4562.977185114053;4623.237165867594;4693.882652933567;4701.341812146234;4708.5997690195345;4727.7163370197895;4694.061187762393;4696.084263568571;4714.4106986626675;4716.646251531218;4723.33873257751;4599.724016559017;4604;4621.075784842978;4648.790804413742;4671.486136525047;4524.117797029548;4611.654125940501;4613.308003799322;4616.9307460387445;4619.191641462798;4428.623566996841;4484.955150448453;4511.142882852248;4541.591256786905;4552.1806074906835;4628.9537104628525;4639.83760568392;4643.814247430065;4646.930296045494;4654.25531914892;4477.574630410106;4533.093381323814;4557.065801510748;4563.087382523575;4579.7252164870215 07:22:34 INFO - PROCESS | 16868 | |1;ext.html;493.5952518934473;508.79648140743706;517.1157320981122;527.4988760677358;539.5252178083286;24890.875545622268;25238.621420678683;25278;25325.493490130208;32178.517322240186;36565;37037.44443833345;37144.25711485769;37162.25675486489;37167.81416092922;7494.1381741099785;7676.923230767705;7686.730964416247;7692.4999875008225;7692.615369231544;7592.962035189817;7726.961365193194;7732.226777322279;7738.574378409186;7739;7667.348275396598;7761.922380776205;7775.961120194391;7780.455368124233;7942.801429964239;7735.6518956646805;7853.253940875607;7879.4484386093;7902.446828721992;7929.801754956144;7718.652660630285;7856.921430785676;7875.842483150363;7888.408369372262;7890.64492097857;36230.27539449223;36768.81615591905;37145.62854371449;37157;37164.25671486555;2831.6460442444695;2861.642294713161;2921.6201893753678;2944.573036909636;2976.866041028159;26831.865840670867;28160.295992600142;28267.941444836786;28375;29320.266993325124;3167.55654208411;3292.27569934614;3314.4696848504122;3324.983375083133;3387.9661203388146;210355;210985;211183;211413.9429302859;211674;47128.29307560389;47848;53528;54002.72998634982;54021;39593.40609890854;56983;57510;57517.71241143768;57624.71187644035;11732;11794.469248883821;11808.232464889754;11828.23116497425;11842.407879606157;9457.527123643791;9611.951940240255;9658.275629327689;9663.178629816544;9670.323077384515;14923.925380373028;18193.181306841223;18416.26334946614;18444.07779611014;18489.53776155607;7133.429325653935;7407;7432.702691892264;7467.1039475263315;7494.587797671181;830.3564737328497;924.5515924776478;935.317218430536;990.1633120013577;1021.8416145497459;25698.229053128434;25793;26045.218643440727;26222.34444138912;26246.34384140412;939.7979434421633;957.7701351675547;969.3844408800321;986.5116767200282;1069.5775168808277;12548.81176782349;13827.723445531234;14295.57113286603;14342.928285358506;14556.927215363856;259267;266547;266844;266873;266893;46195;46565.7671711646;46577.30134047992;46587.76706116448;46641.76679116583;1222.0712258683463;1237.07219585311;1238.6593686736219;1255.5668294438403;1256.597888675615;23293.650595240746;25724.356891077874;26567.734322656524;26993.46013079688;27069.323266918484;41353.793231033655;42006.36990445085;42259.577404226795;42400.36399453949;42402.78798606111;154615;155506;155652.22173889057;155767;155959;23884.641730374406;24120.758792412555;24265.39336516601;25613.487730244917;26169.869150654125;37046.25907481889;37130.51477940852;37437;37766.244675105794;38265.23469530649;30318.84840575783;30574.388512229187;30790.846045769627;31366.215844603154;31509.684903151592;26574.86712566425;29312.706872930998;30833;30894.53658195174;30954.226144346572;28682.71317286884;29165;29208.561871571517;29215.415691685623;29433.264168395963;25936;26491;26538.336541586614;26539.203823885313;26972.595411069244;21032;21206;21255.681164782232;21305.46736331542;21330.89334553317 07:22:34 INFO - PROCESS | 16868 | |2;jquery.html;339.4551744450156;339.76216648346156;341.7590598627967;342.7309561993835;346.9583649962005;12218.266903985766;12633.55782547611;14263.429462821488;14498.767604753595;15843.366265349372;14073.014888957752;14640.926795366007;14840.554783356489;15504.534863954072;15536.456224032161;4715.669903106784;4752.263399173116;4819.445763737162;5028.145215313387;5031.572316353115;4878.48775878533;4901.828436004741;4944.579710724593;4945.307656928033;4949.678270912379;4732.645051621143;4957.454679985199;4965.28003439501;4967.70193788372;4968.428630707479;4855.854324370274;4882.511748825124;4886.926696099561;4892.8532144035735;5012.72430016349;4991.301217829507;5003.5997120230295;5019.623528235397;5020.59835213182;5024.120778863684;11493.31040137586;11506.88493115075;11511.827322590168;11526.135539834462;16825.495235142844;1736.0798776648396;1830.9908450457663;1833.0926191535143;1844.3083843558666;1850.4356171367726;8816.823663526693;8902.109789021111;9017.413868098552;9132.680356187502;9327.860082098774;1727.0760143323262;1731.2642127095935;1770.557360659835;1787.052861983151;1791.6954117800005;47647.76176119097;48730.7563462184;49124.508754912706;49219.261711074;49353;9058.592363343665;9279.118483744034;9343.579538920765;9382.765430864147;9684.806303874024;10896.291741036806;11120.721981950515;11430.257033292975;11522.827157592643;11634.94182529082;6274.2784579773;6372.0760489729655;6468;6603.306652801387;6612.305707900698;6320.336364681642;6324.33594472583;6335.493160547145;6357.332480089524;6369.076483909807;4101.302778527598;4141.668666506672;4164.229617520768;4165.687573432005;4168.291390463629;1593.211360376621;1606.5180445866192;1621.3028397789064;1651.0176445015197;1707.1293640243566;384.72107721901955;395.70915377197736;439.0801271336609;819.610684924656;840.1766269056359;9524.333296669167;9947.353422027545;10037.548310326052;10103.19174466041;10222.539985700661;408.31607058177434;421.6879509163197;423.71822737878966;434.45909842246607;439.1765439800374;6531.8367040823405;8523.445976011539;8616.353773467015;9017.233535149586;9306.720798375924;412717;413152;414350;415706;415830;45967.540324596324;59049.40950590525;61332.69333653303;62655;62812;1060.5757696921294;1083.1659622090947;1086.2721976275914;1086.4459125845876;1100.290312748289;12718.745625087631;13765.587032389045;14159.64600884986;14432.42270309176;14641.780373294196;29488.705112948595;29616.555751664175;30301.545476817424;31309.8434507826;32015.519767203976;35480.46779298364;35635.643643563235;36017;36573.634263657026;36583.63416365909;6403.8399040022505;6558.868822623425;6700.798976030727;6873.862522749617;6908.758193463204;9107.954460227656;10026.348287361297;10070.647527336801;10142.49287535635;10196.4391958443;8390.622421990904;8653.221210091122;8676;8689.13108689126;8793.912060879566;8765.693200737944;9017.504037278013;9115.270778337584;9302.72091837219;9354.158125768714;8589.269912057545;8652.480851148952;8705.782355441164;8707.608157633049;8941.508217048126;6323.241211054703;6374.298827129105;6777.322267773183;6815.829604259933;6904.3095690430555;7798.805029874298;8419.410641255054;8683.956580217058;8721.869171962553;9014.459132452073 07:22:34 INFO - PROCESS | 16868 | |3;mootools.html;1199.9760004799898;1327.5088217359578;1333.3000174908175;1420.417628772203;1691.3741915491262;6003.129546215796;6608.140941677581;6732.889073302899;6744.763933262337;6745.156855393076;6801.591904485735;6995.545289556188;6998.265182155877;7001.474889383291;7014.298570142983;1755.3329734700797;1798.2986635212278;2004.2584243829804;2064.8038436348525;2093.204582258747;2054.4658388818866;2061.134323584098;2071.9378418647466;2072.357569153567;2074.3258441006656;2021.4441028717074;2024.787397323282;2059.742532183477;2073.191455332414;2076.107273872234;1990.6516359637005;2034.6947957806299;2044.100595737878;2045.7442819647545;2047.488127968008;2038.5107574182089;2063.411927600642;2068.338131797825;2069.793020697918;2072.0779253232317;6896.310368963113;6956.234814170437;6958.443324534076;6962.930370696279;6966.721331146748;4054.1283624020975;4131.462909821704;4154.1068670235745;4156.854510092163;4158.147579746175;2578.2523068310165;2683.4230640412407;2686.476137153256;2691.7981151413724;2714.9592756108673;779.4660657449608;799.5402643480022;811.8376324735018;828.2214718164905;828.6519661742083;9490.715278541586;9536.046395360478;9546.42721436716;9556.092171243721;9559;3798.0504873781556;3869.6323849234277;3900.6294402031763;3919.706022048301;3925.8822235332987;8209.343252539782;8219.465734727342;8223.629936652866;8227.670893164206;8230.176982301722;4256.446661933929;4263.914721705611;4265.168292182994;4265.658747300208;4270.188664153801;3816.656500914931;3850.9229815403537;3860.034991252187;3861.0347413146715;3869.28418242626;3005.0984704588536;3062.096681478969;3250.902472925816;3333.7833040852265;3376.898693039213;1059.7562560610947;1064.7072055184885;1074.4466599701161;1087.124864484098;1090.231386872253;1020.2093377632245;1024.1704219582161;1043.6034306963306;1044.550843137443;1053;6537.836554086186;6664.83337916556;6672.7330906764155;6700.66496675174;6701.765438209737;1020.9081182693444;1034.3018462537757;1055.0399136785488;1065.1106326217696;1065.9200559958035;5153.6907785532985;5176.197689358156;5185.481451854785;5186.714730689849;5199.168133098686;7462.664180111908;7990.280874721187;7994.560299183485;7997.720079797179;8003.399745019147;7971.521708697497;7980.122186559473;8093.8381232376205;8128.512289262663;8168.183181681903;6509.153810004669;6637.070810086591;6671.032700258435;6723.697433615401;6752;6242.406971337716;6401.64790936503;6410.583312084699;6414.358564143548;6417.518686098468;7448.925510744823;7606.695732170651;7609.695612175672;7634.198409167179;7719.266669666373;7551.282628150317;7868.134505204537;7975.441719079608;7978.601069946596;7989.400794940519;5697.914531281951;5783.7397317119985;5785.710714464176;5792.391798861059;5798.94201057984;6497.642629655225;6589.769358072444;6598.1422415085735;6610.07458955737;6610.834729131618;6239.344868788893;6275.058741188858;6360.936390636034;6421.71102300407;6468.773592924414;6307.959186734321;6393.2647745508;6409.7115629795835;6459.450946669398;6470.352964703492;6389;6395.808125756234;6420.550561460653;6477.0608261800835;6489.935100648933;6001.219841420588;6066.666333351708;6071.514278857592;6081.087836824335;6081.300650425081;5619.185218143428;5768.105943578752;5774.105013722879;6000.8799824004145;6057.818265452043 07:22:34 INFO - PROCESS | 16868 | |4;prototype.html;301.8807571009451;311.07300245269096;314.42460297655293;314.51093549530486;317.9618445786506;5140.897182056361;5216.843494695156;5248.501392367719;5261.684298942061;5270.762815673294;5144.536991670759;5157.149070403389;5158.148905430599;5159.561437277826;5174.120399532079;3908.17928235071;4018.4374187613757;4108.26051310764;4109.568495307994;4118.958810411895;3992.920141597166;4015.598440155976;4049.97975010126;4052.412400201969;4068.1456894052285;4012.037111093331;4018.035671438848;4035.7982100894837;4063.674906007512;4066.207089617526;3851.326017946848;3965.900852478711;4040.7171497995005;4059.0867054912705;4062.8577999770014;3495.3533596284515;3566.892993210208;3578.3022310649435;3582.8387722552548;3584.5698516177963;4958.107540642683;5015.974920125413;5017.648764586444;5027.321311622957;5027.84916452507;4694;4694.835680751157;4695.553922377403;4696.765161741933;4702.36518070063;5261.815836445744;5444.210589464545;5444.292242008553;5474.7810087596845;5483.424240454735;3837.9040523986846;3839.404892241707;3841.654251117413;3841.9231615367817;3847.7883716395586;5763.423657634245;5790.536757059425;5791.65250084992;5792.333881603628;5792.536597072266;3894.5131858517684;3895.5520115187114;3896.162325100117;3901.726879118491;3904.316744569746;3954.940675889864;3958.287508248543;3959.5050618672667;3962.3858301962664;3984.8406063757707;4466.588042457101;4610.746408947473;4614.700044497097;4616.538346165356;4618.97690511552;5439.129739241703;5441.319835020622;5449;5452.91820622691;5457.69982650958;1434.8565143485778;1438.518096437705;1442.026632023401;1442.1923722715103;1443.364919435445;978.3689520259393;1004.0559885477843;1007.8639383683255;1018.0277834667875;1027.5889644142253;4791.041791641616;4803.063402636452;4808.471068182497;4815.133276010281;4815.422149342031;5667.631603945731;5671.773129074791;5673.687947162863;5676.347220069745;5680.829575112753;4801.18379875422;4801.639877009238;4802.495737947535;4803.423589169322;4811.759412029454;2976.37496125816;3022.440848443045;3048.34460590974;3056.3734434440885;3061.341811510536;5316.734163291897;5322.3879253885525;5326.92009619856;5330.333708286465;5331.573474122061;5792.9710351447975;5805.593608447368;5863.677497737665;5867.3839246879315;5874.148248503943;5307.734613269398;5316.441773613792;5320.52115309624;5322.175062865262;5323.254744335796;5480.177973304037;5644.040513112863;5650.095984642602;5652.576056795675;5654.773809047757;5521.061419558604;5521.861953451196;5524.088525393426;5528.944710552843;5530.5022547970875;5300.178472336794;5310.097283461898;5311.468853114658;5311.973440132774;5313.840584782462;4056.290149223933;4057.3711074783455;4059.3910913363234;4060.1067765091634;4061.086255592468;5499.450054994469;5636.689982051026;5645.266115405136;5651.321841379061;5657.321121465286;5446.482584154499;5454.10007348783;5456;5457.890842183055;5471.343438787371;5454.972725136349;5457.918131227955;5458.044842152687;5463.7814487420055;5467.398586155599;5195.558377537952;5346.358436987586;5349.384820745664;5417.918731219113;5421.349438067457;5298.761555730079;5536.861578460571;5543.279373681396;5551.944480555143;5553.278073850373;5239.607029472729;5248.1340578804065;5342.439043900335;5355.785768569213;5423.186522021729 07:22:34 INFO - PROCESS | 16868 | |5;yui.html;651.6546230497836;695.0339028750035;724.5906063074362;752.3680108708684;755.6448469219469;11531.48108335125;11633.650990470289;11693.064554835613;11728.12039097068;11728.765424691523;11392.202545821776;11564.826527602092;11681.299122052662;11763.470643821027;11774.352410617412;778.3267473635307;790.6797746912509;794.2772077409559;794.7814351053478;795;759.1118391481951;761.3110135327537;761.8209720715628;769.4767558060516;775.3525805952037;807.8465091632601;809.9797505062392;810.1614828652346;810.7608255564593;811.0308181722844;804.899387576553;806.7902345390212;812.0255693168222;813.3574476163853;820.6922404098464;609.0346800321496;610.1457958857591;611.8684482836212;612.4120843989775;613.6870196199925;10465.68602941913;10471.68584942453;10482;10502.002309780559;10507.317024393466;9717.56270967808;9843.655472058443;9894.10953014225;9964.800703985953;10106.949465252626;8668.60991255395;8824.161704638049;10532.94733526335;10646.680599581947;10678.786424271471;3888.241792850395;3888.5333759948703;3946.960530394688;3947.2697550953167;3954.7429417087797;36409.27181456383;37673.434898476546;38317.616823831966;41115.58884411147;41276.174476510605;9217.078292170729;9232.446053236827;9297.581608827619;9342.673006444878;9420.576074076545;15360.923195383952;15498.225088745743;15507.844921550866;15533.922330388275;15972.920135399248;6731.091302674076;6779.525433219627;6817.897731533932;6860.245373008965;6903.827404314932;3480.912977175591;3569.714422846166;3646.070252085701;3737.308597909341;3742.7754334739457;2618.77740392065;2652.7214642462263;2657.1895571850387;2659.8005149613855;2660.3881107345032;492.3599320882838;516.354556803995;516.9689818610896;528.5401700520572;548.8490665067138;413.4212103055686;430.4210836425066;439.5823967231143;454.7680682851769;554.3458718711959;7273.963630181921;7478.962605186939;7529.962350188214;7697.576633285223;7715.729949451855;446.6716963032169;492.39435494341444;523.8716514453984;555.8860433611181;576.0380165124252;3388.6611338865914;3647.8905632831056;3867.2652196082654;3999.34010888206;4042.7978601070417;40520.986975325264;40535.797321013204;40942;42066.158676826904;44502.55497445049;35226.11934701653;35654.108647284025;37202.25595488129;37339.626603734156;37436;37586.62413375831;40752;40884.79557602193;41290.38064429036;41831.58168418338;7864.606769661608;8016.839663206587;8030.879536806836;8047.798805029921;8289.253967142986;28099.578506322014;29019.12942611725;29071;29274.56088158722;29424.705752942198;36341;36568.63431365652;37288.627113728515;37498.8125059373;37612.2477550442;9214.216791572791;9384;9843.655472058443;10262.640807571699;10567;10623.521941512496;10632.681019569425;10676.359418434608;10807.67576972692;11275.887241127484;10475.742910850746;10690.198235132551;10745.892541074802;10904.836427453753;11175.608853690082;10489.52797124116;10548.367097974146;10565.101966332948;10798.622048228275;11129.109671226444;10638.14894808398;10787.083097936764;10793.892061079288;10968.341899486057;11113;8094.31198348147;8182;8526.658933642584;8582.313414926915;8685.8697119542;8351.582420879053;8766.342524310574;8780.121987801169;8823.823523529365;8971.596278167368 07:22:34 INFO - PROCESS | 16868 | __end_tp_report 07:22:34 INFO - PROCESS | 16868 | __start_cc_report 07:22:34 INFO - PROCESS | 16868 | _x_x_mozilla_cycle_collect,852 07:22:34 INFO - PROCESS | 16868 | __end_cc_report 07:22:34 INFO - PROCESS | 16868 | __startTimestamp1452698554823__endTimestamp 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | ------- Summary: start ------- 07:22:34 INFO - PROCESS | 16868 | Number of tests: 6 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#0] dojo.html Cycles:165 Average:4383.05 Median:4509.98 stddev:430.02 (9.5%) stddev-sans-first:406.97 07:22:34 INFO - PROCESS | 16868 | Values: 2564.1 2601.8 2603.2 2617.7 2631.0 4310.3 4343.0 4345.4 4362.6 4385.3 4388.4 4398.7 4404.0 4416.8 4457.9 4103.0 4119.4 4129.9 4136.4 4146.5 4180.5 4235.1 4257.7 4260.2 4265.6 3989.9 4032.3 4056.4 4059.3 4064.9 4094.8 4114.5 4121.3 4136.0 4160.7 4064.2 4084.7 4099.2 4119.8 4128.7 4312.6 4376.5 4392.4 4393.8 4396.1 4687.5 4697.8 4709.3 4770.2 4770.4 4747.6 4752.8 4757.4 4788.8 4796.6 4332.2 4411.7 4414.4 4439.3 4439.6 4827.1 4830.6 4831.1 4853.9 4875.8 4630.6 4643.2 4644.1 4648.3 4676.7 4655.0 4711.3 4718.7 4730.6 4772.8 4657.5 4677.0 4683.7 4693.7 4729.8 4634.6 4635.3 4635.4 4649.9 4681.1 3923.1 3970.8 3974.3 3994.6 4012.7 3516.8 3526.5 3537.5 3564.7 3586.5 4078.9 4100.0 4110.4 4114.5 4169.7 4624.1 4693.6 4700.2 4735.6 4776.2 4132.5 4174.4 4175.1 4197.3 4217.4 4185.9 4232.2 4236.5 4242.0 4295.2 4362.7 4448.2 4462.8 4510.0 4510.8 4724.9 4755.2 4757.4 4764.5 4826.9 4494.4 4512.6 4515.1 4516.7 4563.0 4623.2 4693.9 4701.3 4708.6 4727.7 4694.1 4696.1 4714.4 4716.6 4723.3 4599.7 4604.0 4621.1 4648.8 4671.5 4524.1 4611.7 4613.3 4616.9 4619.2 4428.6 4485.0 4511.1 4541.6 4552.2 4629.0 4639.8 4643.8 4646.9 4654.3 4477.6 4533.1 4557.1 4563.1 4579.7 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#1] ext.html Cycles:180 Average:36534.46 Median:17338.62 stddev:56230.31 (324.3%) stddev-sans-first:56322.93 07:22:34 INFO - PROCESS | 16868 | Values: 493.6 508.8 517.1 527.5 539.5 24890.9 25238.6 25278.0 25325.5 32178.5 36565.0 37037.4 37144.3 37162.3 37167.8 7494.1 7676.9 7686.7 7692.5 7692.6 7593.0 7727.0 7732.2 7738.6 7739.0 7667.3 7761.9 7776.0 7780.5 7942.8 7735.7 7853.3 7879.4 7902.4 7929.8 7718.7 7856.9 7875.8 7888.4 7890.6 36230.3 36768.8 37145.6 37157.0 37164.3 2831.6 2861.6 2921.6 2944.6 2976.9 26831.9 28160.3 28267.9 28375.0 29320.3 3167.6 3292.3 3314.5 3325.0 3388.0 210355.0 210985.0 211183.0 211413.9 211674.0 47128.3 47848.0 53528.0 54002.7 54021.0 39593.4 56983.0 57510.0 57517.7 57624.7 11732.0 11794.5 11808.2 11828.2 11842.4 9457.5 9612.0 9658.3 9663.2 9670.3 14923.9 18193.2 18416.3 18444.1 18489.5 7133.4 7407.0 7432.7 7467.1 7494.6 830.4 924.6 935.3 990.2 1021.8 25698.2 25793.0 26045.2 26222.3 26246.3 939.8 957.8 969.4 986.5 1069.6 12548.8 13827.7 14295.6 14342.9 14556.9 259267.0 266547.0 266844.0 266873.0 266893.0 46195.0 46565.8 46577.3 46587.8 46641.8 1222.1 1237.1 1238.7 1255.6 1256.6 23293.7 25724.4 26567.7 26993.5 27069.3 41353.8 42006.4 42259.6 42400.4 42402.8 154615.0 155506.0 155652.2 155767.0 155959.0 23884.6 24120.8 24265.4 25613.5 26169.9 37046.3 37130.5 37437.0 37766.2 38265.2 30318.8 30574.4 30790.8 31366.2 31509.7 26574.9 29312.7 30833.0 30894.5 30954.2 28682.7 29165.0 29208.6 29215.4 29433.3 25936.0 26491.0 26538.3 26539.2 26972.6 21032.0 21206.0 21255.7 21305.5 21330.9 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#2] jquery.html Cycles:180 Average:22194.48 Median:4837.65 stddev:67680.67 (1399.0%) stddev-sans-first:67850.64 07:22:34 INFO - PROCESS | 16868 | Values: 339.5 339.8 341.8 342.7 347.0 12218.3 12633.6 14263.4 14498.8 15843.4 14073.0 14640.9 14840.6 15504.5 15536.5 4715.7 4752.3 4819.4 5028.1 5031.6 4878.5 4901.8 4944.6 4945.3 4949.7 4732.6 4957.5 4965.3 4967.7 4968.4 4855.9 4882.5 4886.9 4892.9 5012.7 4991.3 5003.6 5019.6 5020.6 5024.1 11493.3 11506.9 11511.8 11526.1 16825.5 1736.1 1831.0 1833.1 1844.3 1850.4 8816.8 8902.1 9017.4 9132.7 9327.9 1727.1 1731.3 1770.6 1787.1 1791.7 47647.8 48730.8 49124.5 49219.3 49353.0 9058.6 9279.1 9343.6 9382.8 9684.8 10896.3 11120.7 11430.3 11522.8 11634.9 6274.3 6372.1 6468.0 6603.3 6612.3 6320.3 6324.3 6335.5 6357.3 6369.1 4101.3 4141.7 4164.2 4165.7 4168.3 1593.2 1606.5 1621.3 1651.0 1707.1 384.7 395.7 439.1 819.6 840.2 9524.3 9947.4 10037.5 10103.2 10222.5 408.3 421.7 423.7 434.5 439.2 6531.8 8523.4 8616.4 9017.2 9306.7 412717.0 413152.0 414350.0 415706.0 415830.0 45967.5 59049.4 61332.7 62655.0 62812.0 1060.6 1083.2 1086.3 1086.4 1100.3 12718.7 13765.6 14159.6 14432.4 14641.8 29488.7 29616.6 30301.5 31309.8 32015.5 35480.5 35635.6 36017.0 36573.6 36583.6 6403.8 6558.9 6700.8 6873.9 6908.8 9108.0 10026.3 10070.6 10142.5 10196.4 8390.6 8653.2 8676.0 8689.1 8793.9 8765.7 9017.5 9115.3 9302.7 9354.2 8589.3 8652.5 8705.8 8707.6 8941.5 6323.2 6374.3 6777.3 6815.8 6904.3 7798.8 8419.4 8684.0 8721.9 9014.5 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#3] mootools.html Cycles:180 Average:4875.65 Median:6030.47 stddev:2510.99 (41.6%) stddev-sans-first:2502.83 07:22:34 INFO - PROCESS | 16868 | Values: 1200.0 1327.5 1333.3 1420.4 1691.4 6003.1 6608.1 6732.9 6744.8 6745.2 6801.6 6995.5 6998.3 7001.5 7014.3 1755.3 1798.3 2004.3 2064.8 2093.2 2054.5 2061.1 2071.9 2072.4 2074.3 2021.4 2024.8 2059.7 2073.2 2076.1 1990.7 2034.7 2044.1 2045.7 2047.5 2038.5 2063.4 2068.3 2069.8 2072.1 6896.3 6956.2 6958.4 6962.9 6966.7 4054.1 4131.5 4154.1 4156.9 4158.1 2578.3 2683.4 2686.5 2691.8 2715.0 779.5 799.5 811.8 828.2 828.7 9490.7 9536.0 9546.4 9556.1 9559.0 3798.1 3869.6 3900.6 3919.7 3925.9 8209.3 8219.5 8223.6 8227.7 8230.2 4256.4 4263.9 4265.2 4265.7 4270.2 3816.7 3850.9 3860.0 3861.0 3869.3 3005.1 3062.1 3250.9 3333.8 3376.9 1059.8 1064.7 1074.4 1087.1 1090.2 1020.2 1024.2 1043.6 1044.6 1053.0 6537.8 6664.8 6672.7 6700.7 6701.8 1020.9 1034.3 1055.0 1065.1 1065.9 5153.7 5176.2 5185.5 5186.7 5199.2 7462.7 7990.3 7994.6 7997.7 8003.4 7971.5 7980.1 8093.8 8128.5 8168.2 6509.2 6637.1 6671.0 6723.7 6752.0 6242.4 6401.6 6410.6 6414.4 6417.5 7448.9 7606.7 7609.7 7634.2 7719.3 7551.3 7868.1 7975.4 7978.6 7989.4 5697.9 5783.7 5785.7 5792.4 5798.9 6497.6 6589.8 6598.1 6610.1 6610.8 6239.3 6275.1 6360.9 6421.7 6468.8 6308.0 6393.3 6409.7 6459.5 6470.4 6389.0 6395.8 6420.6 6477.1 6489.9 6001.2 6066.7 6071.5 6081.1 6081.3 5619.2 5768.1 5774.1 6000.9 6057.8 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#4] prototype.html Cycles:180 Average:4541.53 Median:5150.84 stddev:1317.09 (25.6%) stddev-sans-first:1281.77 07:22:34 INFO - PROCESS | 16868 | Values: 301.9 311.1 314.4 314.5 318.0 5140.9 5216.8 5248.5 5261.7 5270.8 5144.5 5157.1 5158.1 5159.6 5174.1 3908.2 4018.4 4108.3 4109.6 4119.0 3992.9 4015.6 4050.0 4052.4 4068.1 4012.0 4018.0 4035.8 4063.7 4066.2 3851.3 3965.9 4040.7 4059.1 4062.9 3495.4 3566.9 3578.3 3582.8 3584.6 4958.1 5016.0 5017.6 5027.3 5027.8 4694.0 4694.8 4695.6 4696.8 4702.4 5261.8 5444.2 5444.3 5474.8 5483.4 3837.9 3839.4 3841.7 3841.9 3847.8 5763.4 5790.5 5791.7 5792.3 5792.5 3894.5 3895.6 3896.2 3901.7 3904.3 3954.9 3958.3 3959.5 3962.4 3984.8 4466.6 4610.7 4614.7 4616.5 4619.0 5439.1 5441.3 5449.0 5452.9 5457.7 1434.9 1438.5 1442.0 1442.2 1443.4 978.4 1004.1 1007.9 1018.0 1027.6 4791.0 4803.1 4808.5 4815.1 4815.4 5667.6 5671.8 5673.7 5676.3 5680.8 4801.2 4801.6 4802.5 4803.4 4811.8 2976.4 3022.4 3048.3 3056.4 3061.3 5316.7 5322.4 5326.9 5330.3 5331.6 5793.0 5805.6 5863.7 5867.4 5874.1 5307.7 5316.4 5320.5 5322.2 5323.3 5480.2 5644.0 5650.1 5652.6 5654.8 5521.1 5521.9 5524.1 5528.9 5530.5 5300.2 5310.1 5311.5 5312.0 5313.8 4056.3 4057.4 4059.4 4060.1 4061.1 5499.5 5636.7 5645.3 5651.3 5657.3 5446.5 5454.1 5456.0 5457.9 5471.3 5455.0 5457.9 5458.0 5463.8 5467.4 5195.6 5346.4 5349.4 5417.9 5421.3 5298.8 5536.9 5543.3 5551.9 5553.3 5239.6 5248.1 5342.4 5355.8 5423.2 07:22:34 INFO - PROCESS | 16868 | 07:22:34 INFO - PROCESS | 16868 | [#5] yui.html Cycles:180 Average:11521.50 Median:41195.88 stddev:12414.06 (30.1%) stddev-sans-first:12422.04 07:22:34 INFO - PROCESS | 16868 | Values: 651.7 695.0 724.6 752.4 755.6 11531.5 11633.7 11693.1 11728.1 11728.8 11392.2 11564.8 11681.3 11763.5 11774.4 778.3 790.7 794.3 794.8 795.0 759.1 761.3 761.8 769.5 775.4 807.8 810.0 810.2 810.8 811.0 804.9 806.8 812.0 813.4 820.7 609.0 610.1 611.9 612.4 613.7 10465.7 10471.7 10482.0 10502.0 10507.3 9717.6 9843.7 9894.1 9964.8 10106.9 8668.6 8824.2 10532.9 10646.7 10678.8 3888.2 3888.5 3947.0 3947.3 3954.7 36409.3 37673.4 38317.6 41115.6 41276.2 9217.1 9232.4 9297.6 9342.7 9420.6 15360.9 15498.2 15507.8 15533.9 15972.9 6731.1 6779.5 6817.9 6860.2 6903.8 3480.9 3569.7 3646.1 3737.3 3742.8 2618.8 2652.7 2657.2 2659.8 2660.4 492.4 516.4 517.0 528.5 548.8 413.4 430.4 439.6 454.8 554.3 7274.0 7479.0 7530.0 7697.6 7715.7 446.7 492.4 523.9 555.9 576.0 3388.7 3647.9 3867.3 3999.3 4042.8 40521.0 40535.8 40942.0 42066.2 44502.6 35226.1 35654.1 37202.3 37339.6 37436.0 37586.6 40752.0 40884.8 41290.4 41831.6 7864.6 8016.8 8030.9 8047.8 8289.3 28099.6 29019.1 29071.0 29274.6 29424.7 36341.0 36568.6 37288.6 37498.8 37612.2 9214.2 9384.0 9843.7 10262.6 10567.0 10623.5 10632.7 10676.4 10807.7 11275.9 10475.7 10690.2 10745.9 10904.8 11175.6 10489.5 10548.4 10565.1 10798.6 11129.1 10638.1 10787.1 10793.9 10968.3 11113.0 8094.3 8182.0 8526.7 8582.3 8685.9 8351.6 8766.3 8780.1 8823.8 8971.6 07:22:34 INFO - PROCESS | 16868 | -------- Summary: end -------- 07:22:34 INFO - PROCESS | 16868 | 07:22:35 INFO - TEST-INFO | 16868: exit 0 07:22:35 INFO - TEST-OK | dromaeo_css | took 1116288ms 07:22:35 INFO - TEST-START | kraken 07:22:35 INFO - operating with platform_type : linux_ 07:22:35 INFO - Initialising browser for kraken test... 07:22:35 INFO - TEST-INFO | started process 17057 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJw5Y95/profile http://localhost:50154/getInfo.html) 07:22:39 INFO - PROCESS | 17057 | __metrics Screen width/height:1600/1200 07:22:39 INFO - PROCESS | 17057 | colorDepth:24 07:22:39 INFO - PROCESS | 17057 | Browser inner width/height: 1024/697 07:22:39 INFO - PROCESS | 17057 | __metrics 07:22:40 INFO - PROCESS | 17057 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:22:40 INFO - PROCESS | 17057 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:22:40 INFO - TEST-INFO | 17057: exit 0 07:22:40 INFO - Browser initialized. 07:22:40 INFO - Running cycle 1/1 for kraken test... 07:22:40 INFO - TEST-INFO | started process 17141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJw5Y95/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:22:52 INFO - PROCESS | 17141 | RSS: Main: 149946368 07:22:52 INFO - PROCESS | 17141 | 07:22:55 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-beat-detection) 07:22:56 INFO - PROCESS | 17141 | RSS: Main: 188063744 07:22:56 INFO - PROCESS | 17141 | 07:22:58 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-dft) 07:22:59 INFO - PROCESS | 17141 | RSS: Main: 178077696 07:22:59 INFO - PROCESS | 17141 | 07:23:02 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-fft) 07:23:03 INFO - PROCESS | 17141 | RSS: Main: 161902592 07:23:03 INFO - PROCESS | 17141 | 07:23:05 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50154/tests/kraken/driver.html?testName=audio-oscillator) 07:23:05 INFO - PROCESS | 17141 | RSS: Main: 164012032 07:23:05 INFO - PROCESS | 17141 | 07:23:08 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:23:08 INFO - PROCESS | 17141 | RSS: Main: 166604800 07:23:08 INFO - PROCESS | 17141 | 07:23:11 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-darkroom) 07:23:12 INFO - PROCESS | 17141 | RSS: Main: 166572032 07:23:12 INFO - PROCESS | 17141 | 07:23:15 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50154/tests/kraken/driver.html?testName=imaging-desaturate) 07:23:16 INFO - PROCESS | 17141 | RSS: Main: 166047744 07:23:16 INFO - PROCESS | 17141 | 07:23:19 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50154/tests/kraken/driver.html?testName=json-parse-financial) 07:23:19 INFO - PROCESS | 17141 | RSS: Main: 165253120 07:23:19 INFO - PROCESS | 17141 | 07:23:21 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:23:21 INFO - PROCESS | 17141 | RSS: Main: 177946624 07:23:21 INFO - PROCESS | 17141 | 07:23:23 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:23:24 INFO - PROCESS | 17141 | RSS: Main: 174723072 07:23:24 INFO - PROCESS | 17141 | 07:23:26 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:23:27 INFO - PROCESS | 17141 | RSS: Main: 185962496 07:23:27 INFO - PROCESS | 17141 | 07:23:29 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:23:30 INFO - PROCESS | 17141 | RSS: Main: 190312448 07:23:30 INFO - PROCESS | 17141 | 07:23:32 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:23:33 INFO - PROCESS | 17141 | RSS: Main: 187265024 07:23:33 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | Cycle 1(1): loaded http://localhost:50154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50154/tests/kraken/driver.html?testName=ai-astar) 07:23:35 INFO - PROCESS | 17141 | RSS: Main: 243814400 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | __start_tp_report 07:23:35 INFO - PROCESS | 17141 | _x_x_mozilla_page_load 07:23:35 INFO - PROCESS | 17141 | _x_x_mozilla_page_load_details 07:23:35 INFO - PROCESS | 17141 | |i|pagename|runs| 07:23:35 INFO - PROCESS | 17141 | |0;ai-astar;114;116;111;113;115;114;105;114;114;115 07:23:35 INFO - PROCESS | 17141 | |1;audio-beat-detection;163;139;165;178;133;157;161;130;171;128 07:23:35 INFO - PROCESS | 17141 | |2;audio-dft;162;162;161;164;160;160;162;162;161;162 07:23:35 INFO - PROCESS | 17141 | |3;audio-fft;74;74;100;92;72;73;73;107;92;73 07:23:35 INFO - PROCESS | 17141 | |4;audio-oscillator;98;97;138;97;98;97;147;97;98;137 07:23:35 INFO - PROCESS | 17141 | |5;imaging-gaussian-blur;109;109;110;110;109;109;109;110;109;109 07:23:35 INFO - PROCESS | 17141 | |6;imaging-darkroom;148;148;148;148;146;148;147;148;147;146 07:23:35 INFO - PROCESS | 17141 | |7;imaging-desaturate;95;96;96;96;95;95;95;95;95;95 07:23:35 INFO - PROCESS | 17141 | |8;json-parse-financial;67;66;67;66;66;67;67;77;65;64 07:23:35 INFO - PROCESS | 17141 | |9;json-stringify-tinderbox;66;68;67;66;67;66;66;68;66;67 07:23:35 INFO - PROCESS | 17141 | |10;stanford-crypto-aes;82;84;84;84;84;83;84;84;88;83 07:23:35 INFO - PROCESS | 17141 | |11;stanford-crypto-ccm;122;124;119;125;122;126;120;126;135;133 07:23:35 INFO - PROCESS | 17141 | |12;stanford-crypto-pbkdf2;149;136;148;145;149;139;147;149;147;150 07:23:35 INFO - PROCESS | 17141 | |13;stanford-crypto-sha256-iterative;71;71;72;71;70;72;71;73;70;70 07:23:35 INFO - PROCESS | 17141 | __end_tp_report 07:23:35 INFO - PROCESS | 17141 | __start_cc_report 07:23:35 INFO - PROCESS | 17141 | _x_x_mozilla_cycle_collect,1033 07:23:35 INFO - PROCESS | 17141 | __end_cc_report 07:23:35 INFO - PROCESS | 17141 | __startTimestamp1452698615537__endTimestamp 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | ------- Summary: start ------- 07:23:35 INFO - PROCESS | 17141 | Number of tests: 14 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.14 (2.8%) stddev-sans-first:3.32 07:23:35 INFO - PROCESS | 17141 | Values: 114.0 116.0 111.0 113.0 115.0 114.0 105.0 114.0 114.0 115.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:162.00 stddev:18.32 (11.3%) stddev-sans-first:19.03 07:23:35 INFO - PROCESS | 17141 | Values: 163.0 139.0 165.0 178.0 133.0 157.0 161.0 130.0 171.0 128.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.24 07:23:35 INFO - PROCESS | 17141 | Values: 162.0 162.0 161.0 164.0 160.0 160.0 162.0 162.0 161.0 162.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#3] audio-fft Cycles:10 Average:83.00 Median:73.50 stddev:13.37 (18.2%) stddev-sans-first:13.78 07:23:35 INFO - PROCESS | 17141 | Values: 74.0 74.0 100.0 92.0 72.0 73.0 73.0 107.0 92.0 73.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:97.00 stddev:21.05 (21.7%) stddev-sans-first:21.84 07:23:35 INFO - PROCESS | 17141 | Values: 98.0 97.0 138.0 97.0 98.0 97.0 147.0 97.0 98.0 137.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 07:23:35 INFO - PROCESS | 17141 | Values: 109.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 109.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 07:23:35 INFO - PROCESS | 17141 | Values: 148.0 148.0 148.0 148.0 146.0 148.0 147.0 148.0 147.0 146.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 07:23:35 INFO - PROCESS | 17141 | Values: 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:67.00 stddev:3.58 (5.3%) stddev-sans-first:3.80 07:23:35 INFO - PROCESS | 17141 | Values: 67.0 66.0 67.0 66.0 66.0 67.0 67.0 77.0 65.0 64.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 07:23:35 INFO - PROCESS | 17141 | Values: 66.0 68.0 67.0 66.0 67.0 66.0 66.0 68.0 66.0 67.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.56 (1.9%) stddev-sans-first:1.48 07:23:35 INFO - PROCESS | 17141 | Values: 82.0 84.0 84.0 84.0 84.0 83.0 84.0 84.0 88.0 83.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:125.50 stddev:5.22 (4.2%) stddev-sans-first:5.41 07:23:35 INFO - PROCESS | 17141 | Values: 122.0 124.0 119.0 125.0 122.0 126.0 120.0 126.0 135.0 133.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:148.50 stddev:4.70 (3.2%) stddev-sans-first:4.85 07:23:35 INFO - PROCESS | 17141 | Values: 149.0 136.0 148.0 145.0 149.0 139.0 147.0 149.0 147.0 150.0 07:23:35 INFO - PROCESS | 17141 | 07:23:35 INFO - PROCESS | 17141 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:0.99 (1.4%) stddev-sans-first:1.05 07:23:35 INFO - PROCESS | 17141 | Values: 71.0 71.0 72.0 71.0 70.0 72.0 71.0 73.0 70.0 70.0 07:23:35 INFO - PROCESS | 17141 | -------- Summary: end -------- 07:23:35 INFO - PROCESS | 17141 | 07:23:36 INFO - TEST-INFO | 17141: exit 0 07:23:36 INFO - TEST-OK | kraken | took 60871ms 07:23:36 INFO - TEST-START | v8_7 07:23:36 INFO - operating with platform_type : linux_ 07:23:36 INFO - Initialising browser for v8_7 test... 07:23:36 INFO - TEST-INFO | started process 17387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd3lTt/profile http://localhost:50154/getInfo.html) 07:23:40 INFO - PROCESS | 17387 | __metrics Screen width/height:1600/1200 07:23:40 INFO - PROCESS | 17387 | colorDepth:24 07:23:40 INFO - PROCESS | 17387 | Browser inner width/height: 1024/697 07:23:40 INFO - PROCESS | 17387 | __metrics 07:23:40 INFO - PROCESS | 17387 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:23:40 INFO - PROCESS | 17387 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:23:41 INFO - TEST-INFO | 17387: exit 0 07:23:41 INFO - Browser initialized. 07:23:41 INFO - Running cycle 1/1 for v8_7 test... 07:23:41 INFO - TEST-INFO | started process 17467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppd3lTt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:23:53 INFO - PROCESS | 17467 | RSS: Main: 150667264 07:23:53 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | Cycle 1(1): loaded http://localhost:50154/tests/v8_7/run.html (next: http://localhost:50154/tests/v8_7/run.html) 07:24:16 INFO - PROCESS | 17467 | RSS: Main: 444522496 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | __start_tp_report 07:24:16 INFO - PROCESS | 17467 | _x_x_mozilla_page_load 07:24:16 INFO - PROCESS | 17467 | _x_x_mozilla_page_load_details 07:24:16 INFO - PROCESS | 17467 | |i|pagename|runs| 07:24:16 INFO - PROCESS | 17467 | |0;Richards;167.78523489932886 07:24:16 INFO - PROCESS | 17467 | |1;DeltaBlue;190.11406844106463 07:24:16 INFO - PROCESS | 17467 | |2;Encrypt;277.9321845469705 07:24:16 INFO - PROCESS | 17467 | |3;Decrypt;5154.639175257732 07:24:16 INFO - PROCESS | 17467 | |4;RayTrace;2014.0845070422536 07:24:16 INFO - PROCESS | 17467 | |5;Earley;813.0081300813008 07:24:16 INFO - PROCESS | 17467 | |6;Boyer;12395.061728395061 07:24:16 INFO - PROCESS | 17467 | |7;RegExp;44717.391304347824 07:24:16 INFO - PROCESS | 17467 | |8;Splay;600.9615384615385 07:24:16 INFO - PROCESS | 17467 | |9;NavierStokes;4845.410628019324 07:24:16 INFO - PROCESS | 17467 | __end_tp_report 07:24:16 INFO - PROCESS | 17467 | __startTimestamp1452698656610__endTimestamp 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | ------- Summary: start ------- 07:24:16 INFO - PROCESS | 17467 | Number of tests: 10 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#0] Richards Cycles:1 Average:167.79 Median:167.79 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 167.8 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#1] DeltaBlue Cycles:1 Average:190.11 Median:190.11 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 190.1 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 277.9 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 5154.6 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 2014.1 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#5] Earley Cycles:1 Average:813.01 Median:813.01 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 813.0 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 12395.1 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#7] RegExp Cycles:1 Average:44717.39 Median:44717.39 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 44717.4 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#8] Splay Cycles:1 Average:600.96 Median:600.96 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 601.0 07:24:16 INFO - PROCESS | 17467 | 07:24:16 INFO - PROCESS | 17467 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 07:24:16 INFO - PROCESS | 17467 | Values: 4845.4 07:24:16 INFO - PROCESS | 17467 | -------- Summary: end -------- 07:24:16 INFO - PROCESS | 17467 | 07:24:17 INFO - TEST-INFO | 17467: exit 0 07:24:17 INFO - TEST-OK | v8_7 | took 41089ms 07:24:17 INFO - SUITE-END | took 1218s 07:24:18 INFO - Completed test suite (00:20:18) 07:24:18 INFO - Working with test: dromaeo_css 07:24:18 INFO - Generating results file: dromaeo_css 07:24:18 INFO - Working with test: kraken 07:24:18 INFO - Generating results file: kraken 07:24:18 INFO - javascript benchmark 07:24:18 INFO - Working with test: v8_7 07:24:18 INFO - Generating results file: v8_7 07:24:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:24:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:24:18 INFO - process_Request line: dromaeo_css 5946.84 graph.html#tests=[[72,132,35]] 07:24:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:24:18 INFO - process_Request line: kraken 1532.70 graph.html#tests=[[232,132,35]] 07:24:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:24:18 INFO - process_Request line: v8_7 18704.19 graph.html#tests=[[230,132,35]] 07:24:18 INFO - RETURN: dromaeo_css: 5946.84 07:24:18 INFO - RETURN: kraken: 1532.70 07:24:18 INFO - RETURN: v8_7: 18704.19 07:24:18 INFO - javascript benchmark 07:24:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2564.141012760725, 2601.791856651468, 2603.1930101668495, 2617.7251388604195, 2630.9999999999995, 4310.310350343945, 4342.978285108574, 4345.413369195162, 4362.563743625636, 4385.2764293891505, 4388.429504164455, 4398.736075835444, 4403.977980110103, 4416.801243944023, 4457.910841783162, 4102.97948510257, 4119.382092686091, 4129.938050929239, 4136.4415803866395, 4146.481689788777, 4180.519240287375, 4235.110626768383, 4257.723247988871, 4260.211860805761, 4265.552117027699, 3989.880303590897, 4032.334664780308, 4056.411820286042, 4059.3099173140636, 4064.9390259146135, 4094.815733291979, 4114.506259248909, 4121.340585506335, 4135.958640413587, 4160.667146628262, 4064.2074795414906, 4084.6732261419015, 4099.241640296555, 4119.8352065917325, 4128.731632443882, 4312.568743125694, 4376.518582955872, 4392.38506609075, 4393.824247030115, 4396.120775844844, 4687.531246875319, 4697.8355757548325, 4709.340692303081, 4770.212914869043, 4770.356001939728, 4747.572718455355, 4752.833650822205, 4757.3815403997605, 4788.784504697297, 4796.616270698336, 4332.241857674926, 4411.713238639478, 4414.359917811899, 4439.334099884978, 4439.622632076277, 4827.08285425768, 4830.589399900978, 4831.057943701015, 4853.9029219416125, 4875.804967801319, 4630.6063984561015, 4643.164230438553, 4644.140833945731, 4648.279516674921, 4676.719396836201, 4655.045715628288, 4711.293306004059, 4718.7168769873915, 4730.62155027597, 4772.809087636456, 4657.510961349078, 4676.976615116902, 4683.695559788603, 4693.718376897329, 4729.763511824395, 4634.559716826896, 4635.281531362644, 4635.420572428447, 4649.883752906205, 4681.133990211822, 3923.1172986077904, 3970.781607011584, 3974.324364857981, 3994.580569040267, 4012.658923991435, 3516.841742121611, 3526.5239192708655, 3537.451694987281, 3564.7326450515798, 3586.533750612456, 4078.877633670995, 4099.959000410017, 4110.375253904025, 4114.547399786021, 4169.708120431601, 4624.1445332613575, 4693.647976401783, 4700.177468942921, 4735.550122738335, 4776.2119250324, 4132.524759652679, 4174.352975288835, 4175.10235299406, 4197.3074442717225, 4217.388478670576, 4185.874423767292, 4232.153569286155, 4236.5128010278595, 4242.045539753531, 4295.162443323585, 4362.672799540111, 4448.154850578379, 4462.799174037111, 4509.977450112794, 4510.819567217274, 4724.881877953078, 4755.2153894607, 4757.429108507002, 4764.49972752856, 4826.903461930812, 4494.415725955605, 4512.571305725951, 4515.1195516873895, 4516.7289962601035, 4562.977185114053, 4623.237165867594, 4693.882652933567, 4701.341812146234, 4708.5997690195345, 4727.7163370197895, 4694.061187762393, 4696.084263568571, 4714.4106986626675, 4716.646251531218, 4723.33873257751, 4599.724016559017, 4604.0, 4621.075784842978, 4648.790804413742, 4671.486136525047, 4524.117797029548, 4611.654125940501, 4613.308003799322, 4616.9307460387445, 4619.191641462798, 4428.623566996841, 4484.955150448453, 4511.142882852248, 4541.591256786905, 4552.1806074906835, 4628.9537104628525, 4639.83760568392, 4643.814247430065, 4646.930296045494, 4654.25531914892, 4477.574630410106, 4533.093381323814, 4557.065801510748, 4563.087382523575, 4579.7252164870215], "unit": "score", "name": "dojo.html", "value": 4357.7367074162685}, {"lowerIsBetter": false, "replicates": [493.5952518934473, 508.79648140743706, 517.1157320981122, 527.4988760677358, 539.5252178083286, 24890.875545622268, 25238.621420678683, 25278.0, 25325.493490130208, 32178.517322240186, 36565.0, 37037.44443833345, 37144.25711485769, 37162.25675486489, 37167.81416092922, 7494.1381741099785, 7676.923230767705, 7686.730964416247, 7692.4999875008225, 7692.615369231544, 7592.962035189817, 7726.961365193194, 7732.226777322279, 7738.574378409186, 7739.0, 7667.348275396598, 7761.922380776205, 7775.961120194391, 7780.455368124233, 7942.801429964239, 7735.6518956646805, 7853.253940875607, 7879.4484386093, 7902.446828721992, 7929.801754956144, 7718.652660630285, 7856.921430785676, 7875.842483150363, 7888.408369372262, 7890.64492097857, 36230.27539449223, 36768.81615591905, 37145.62854371449, 37157.0, 37164.25671486555, 2831.6460442444695, 2861.642294713161, 2921.6201893753678, 2944.573036909636, 2976.866041028159, 26831.865840670867, 28160.295992600142, 28267.941444836786, 28375.0, 29320.266993325124, 3167.55654208411, 3292.27569934614, 3314.4696848504122, 3324.983375083133, 3387.9661203388146, 210355.0, 210985.0, 211183.0, 211413.9429302859, 211674.0, 47128.29307560389, 47848.0, 53528.0, 54002.72998634982, 54021.0, 39593.40609890854, 56983.0, 57510.0, 57517.71241143768, 57624.71187644035, 11732.0, 11794.469248883821, 11808.232464889754, 11828.23116497425, 11842.407879606157, 9457.527123643791, 9611.951940240255, 9658.275629327689, 9663.178629816544, 9670.323077384515, 14923.925380373028, 18193.181306841223, 18416.26334946614, 18444.07779611014, 18489.53776155607, 7133.429325653935, 7407.0, 7432.702691892264, 7467.1039475263315, 7494.587797671181, 830.3564737328497, 924.5515924776478, 935.317218430536, 990.1633120013577, 1021.8416145497459, 25698.229053128434, 25793.0, 26045.218643440727, 26222.34444138912, 26246.34384140412, 939.7979434421633, 957.7701351675547, 969.3844408800321, 986.5116767200282, 1069.5775168808277, 12548.81176782349, 13827.723445531234, 14295.57113286603, 14342.928285358506, 14556.927215363856, 259267.0, 266547.0, 266844.0, 266873.0, 266893.0, 46195.0, 46565.7671711646, 46577.30134047992, 46587.76706116448, 46641.76679116583, 1222.0712258683463, 1237.07219585311, 1238.6593686736219, 1255.5668294438403, 1256.597888675615, 23293.650595240746, 25724.356891077874, 26567.734322656524, 26993.46013079688, 27069.323266918484, 41353.793231033655, 42006.36990445085, 42259.577404226795, 42400.36399453949, 42402.78798606111, 154615.0, 155506.0, 155652.22173889057, 155767.0, 155959.0, 23884.641730374406, 24120.758792412555, 24265.39336516601, 25613.487730244917, 26169.869150654125, 37046.25907481889, 37130.51477940852, 37437.0, 37766.244675105794, 38265.23469530649, 30318.84840575783, 30574.388512229187, 30790.846045769627, 31366.215844603154, 31509.684903151592, 26574.86712566425, 29312.706872930998, 30833.0, 30894.53658195174, 30954.226144346572, 28682.71317286884, 29165.0, 29208.561871571517, 29215.415691685623, 29433.264168395963, 25936.0, 26491.0, 26538.336541586614, 26539.203823885313, 26972.595411069244, 21032.0, 21206.0, 21255.681164782232, 21305.46736331542, 21330.89334553317], "unit": "score", "name": "ext.html", "value": 15831.665750702427}, {"lowerIsBetter": false, "replicates": [339.4551744450156, 339.76216648346156, 341.7590598627967, 342.7309561993835, 346.9583649962005, 12218.266903985766, 12633.55782547611, 14263.429462821488, 14498.767604753595, 15843.366265349372, 14073.014888957752, 14640.926795366007, 14840.554783356489, 15504.534863954072, 15536.456224032161, 4715.669903106784, 4752.263399173116, 4819.445763737162, 5028.145215313387, 5031.572316353115, 4878.48775878533, 4901.828436004741, 4944.579710724593, 4945.307656928033, 4949.678270912379, 4732.645051621143, 4957.454679985199, 4965.28003439501, 4967.70193788372, 4968.428630707479, 4855.854324370274, 4882.511748825124, 4886.926696099561, 4892.8532144035735, 5012.72430016349, 4991.301217829507, 5003.5997120230295, 5019.623528235397, 5020.59835213182, 5024.120778863684, 11493.31040137586, 11506.88493115075, 11511.827322590168, 11526.135539834462, 16825.495235142844, 1736.0798776648396, 1830.9908450457663, 1833.0926191535143, 1844.3083843558666, 1850.4356171367726, 8816.823663526693, 8902.109789021111, 9017.413868098552, 9132.680356187502, 9327.860082098774, 1727.0760143323262, 1731.2642127095935, 1770.557360659835, 1787.052861983151, 1791.6954117800005, 47647.76176119097, 48730.7563462184, 49124.508754912706, 49219.261711074, 49353.0, 9058.592363343665, 9279.118483744034, 9343.579538920765, 9382.765430864147, 9684.806303874024, 10896.291741036806, 11120.721981950515, 11430.257033292975, 11522.827157592643, 11634.94182529082, 6274.2784579773, 6372.0760489729655, 6468.0, 6603.306652801387, 6612.305707900698, 6320.336364681642, 6324.33594472583, 6335.493160547145, 6357.332480089524, 6369.076483909807, 4101.302778527598, 4141.668666506672, 4164.229617520768, 4165.687573432005, 4168.291390463629, 1593.211360376621, 1606.5180445866192, 1621.3028397789064, 1651.0176445015197, 1707.1293640243566, 384.72107721901955, 395.70915377197736, 439.0801271336609, 819.610684924656, 840.1766269056359, 9524.333296669167, 9947.353422027545, 10037.548310326052, 10103.19174466041, 10222.539985700661, 408.31607058177434, 421.6879509163197, 423.71822737878966, 434.45909842246607, 439.1765439800374, 6531.8367040823405, 8523.445976011539, 8616.353773467015, 9017.233535149586, 9306.720798375924, 412717.0, 413152.0, 414350.0, 415706.0, 415830.0, 45967.540324596324, 59049.40950590525, 61332.69333653303, 62655.0, 62812.0, 1060.5757696921294, 1083.1659622090947, 1086.2721976275914, 1086.4459125845876, 1100.290312748289, 12718.745625087631, 13765.587032389045, 14159.64600884986, 14432.42270309176, 14641.780373294196, 29488.705112948595, 29616.555751664175, 30301.545476817424, 31309.8434507826, 32015.519767203976, 35480.46779298364, 35635.643643563235, 36017.0, 36573.634263657026, 36583.63416365909, 6403.8399040022505, 6558.868822623425, 6700.798976030727, 6873.862522749617, 6908.758193463204, 9107.954460227656, 10026.348287361297, 10070.647527336801, 10142.49287535635, 10196.4391958443, 8390.622421990904, 8653.221210091122, 8676.0, 8689.13108689126, 8793.912060879566, 8765.693200737944, 9017.504037278013, 9115.270778337584, 9302.72091837219, 9354.158125768714, 8589.269912057545, 8652.480851148952, 8705.782355441164, 8707.608157633049, 8941.508217048126, 6323.241211054703, 6374.298827129105, 6777.322267773183, 6815.829604259933, 6904.3095690430555, 7798.805029874298, 8419.410641255054, 8683.956580217058, 8721.869171962553, 9014.459132452073], "unit": "score", "name": "jquery.html", "value": 6972.9108123069}, {"lowerIsBetter": false, "replicates": [1199.9760004799898, 1327.5088217359578, 1333.3000174908175, 1420.417628772203, 1691.3741915491262, 6003.129546215796, 6608.140941677581, 6732.889073302899, 6744.763933262337, 6745.156855393076, 6801.591904485735, 6995.545289556188, 6998.265182155877, 7001.474889383291, 7014.298570142983, 1755.3329734700797, 1798.2986635212278, 2004.2584243829804, 2064.8038436348525, 2093.204582258747, 2054.4658388818866, 2061.134323584098, 2071.9378418647466, 2072.357569153567, 2074.3258441006656, 2021.4441028717074, 2024.787397323282, 2059.742532183477, 2073.191455332414, 2076.107273872234, 1990.6516359637005, 2034.6947957806299, 2044.100595737878, 2045.7442819647545, 2047.488127968008, 2038.5107574182089, 2063.411927600642, 2068.338131797825, 2069.793020697918, 2072.0779253232317, 6896.310368963113, 6956.234814170437, 6958.443324534076, 6962.930370696279, 6966.721331146748, 4054.1283624020975, 4131.462909821704, 4154.1068670235745, 4156.854510092163, 4158.147579746175, 2578.2523068310165, 2683.4230640412407, 2686.476137153256, 2691.7981151413724, 2714.9592756108673, 779.4660657449608, 799.5402643480022, 811.8376324735018, 828.2214718164905, 828.6519661742083, 9490.715278541586, 9536.046395360478, 9546.42721436716, 9556.092171243721, 9559.0, 3798.0504873781556, 3869.6323849234277, 3900.6294402031763, 3919.706022048301, 3925.8822235332987, 8209.343252539782, 8219.465734727342, 8223.629936652866, 8227.670893164206, 8230.176982301722, 4256.446661933929, 4263.914721705611, 4265.168292182994, 4265.658747300208, 4270.188664153801, 3816.656500914931, 3850.9229815403537, 3860.034991252187, 3861.0347413146715, 3869.28418242626, 3005.0984704588536, 3062.096681478969, 3250.902472925816, 3333.7833040852265, 3376.898693039213, 1059.7562560610947, 1064.7072055184885, 1074.4466599701161, 1087.124864484098, 1090.231386872253, 1020.2093377632245, 1024.1704219582161, 1043.6034306963306, 1044.550843137443, 1053.0, 6537.836554086186, 6664.83337916556, 6672.7330906764155, 6700.66496675174, 6701.765438209737, 1020.9081182693444, 1034.3018462537757, 1055.0399136785488, 1065.1106326217696, 1065.9200559958035, 5153.6907785532985, 5176.197689358156, 5185.481451854785, 5186.714730689849, 5199.168133098686, 7462.664180111908, 7990.280874721187, 7994.560299183485, 7997.720079797179, 8003.399745019147, 7971.521708697497, 7980.122186559473, 8093.8381232376205, 8128.512289262663, 8168.183181681903, 6509.153810004669, 6637.070810086591, 6671.032700258435, 6723.697433615401, 6752.0, 6242.406971337716, 6401.64790936503, 6410.583312084699, 6414.358564143548, 6417.518686098468, 7448.925510744823, 7606.695732170651, 7609.695612175672, 7634.198409167179, 7719.266669666373, 7551.282628150317, 7868.134505204537, 7975.441719079608, 7978.601069946596, 7989.400794940519, 5697.914531281951, 5783.7397317119985, 5785.710714464176, 5792.391798861059, 5798.94201057984, 6497.642629655225, 6589.769358072444, 6598.1422415085735, 6610.07458955737, 6610.834729131618, 6239.344868788893, 6275.058741188858, 6360.936390636034, 6421.71102300407, 6468.773592924414, 6307.959186734321, 6393.2647745508, 6409.7115629795835, 6459.450946669398, 6470.352964703492, 6389.0, 6395.808125756234, 6420.550561460653, 6477.0608261800835, 6489.935100648933, 6001.219841420588, 6066.666333351708, 6071.514278857592, 6081.087836824335, 6081.300650425081, 5619.185218143428, 5768.105943578752, 5774.105013722879, 6000.8799824004145, 6057.818265452043], "unit": "score", "name": "mootools.html", "value": 4007.4446853050267}, {"lowerIsBetter": false, "replicates": [301.8807571009451, 311.07300245269096, 314.42460297655293, 314.51093549530486, 317.9618445786506, 5140.897182056361, 5216.843494695156, 5248.501392367719, 5261.684298942061, 5270.762815673294, 5144.536991670759, 5157.149070403389, 5158.148905430599, 5159.561437277826, 5174.120399532079, 3908.17928235071, 4018.4374187613757, 4108.26051310764, 4109.568495307994, 4118.958810411895, 3992.920141597166, 4015.598440155976, 4049.97975010126, 4052.412400201969, 4068.1456894052285, 4012.037111093331, 4018.035671438848, 4035.7982100894837, 4063.674906007512, 4066.207089617526, 3851.326017946848, 3965.900852478711, 4040.7171497995005, 4059.0867054912705, 4062.8577999770014, 3495.3533596284515, 3566.892993210208, 3578.3022310649435, 3582.8387722552548, 3584.5698516177963, 4958.107540642683, 5015.974920125413, 5017.648764586444, 5027.321311622957, 5027.84916452507, 4694.0, 4694.835680751157, 4695.553922377403, 4696.765161741933, 4702.36518070063, 5261.815836445744, 5444.210589464545, 5444.292242008553, 5474.7810087596845, 5483.424240454735, 3837.9040523986846, 3839.404892241707, 3841.654251117413, 3841.9231615367817, 3847.7883716395586, 5763.423657634245, 5790.536757059425, 5791.65250084992, 5792.333881603628, 5792.536597072266, 3894.5131858517684, 3895.5520115187114, 3896.162325100117, 3901.726879118491, 3904.316744569746, 3954.940675889864, 3958.287508248543, 3959.5050618672667, 3962.3858301962664, 3984.8406063757707, 4466.588042457101, 4610.746408947473, 4614.700044497097, 4616.538346165356, 4618.97690511552, 5439.129739241703, 5441.319835020622, 5449.0, 5452.91820622691, 5457.69982650958, 1434.8565143485778, 1438.518096437705, 1442.026632023401, 1442.1923722715103, 1443.364919435445, 978.3689520259393, 1004.0559885477843, 1007.8639383683255, 1018.0277834667875, 1027.5889644142253, 4791.041791641616, 4803.063402636452, 4808.471068182497, 4815.133276010281, 4815.422149342031, 5667.631603945731, 5671.773129074791, 5673.687947162863, 5676.347220069745, 5680.829575112753, 4801.18379875422, 4801.639877009238, 4802.495737947535, 4803.423589169322, 4811.759412029454, 2976.37496125816, 3022.440848443045, 3048.34460590974, 3056.3734434440885, 3061.341811510536, 5316.734163291897, 5322.3879253885525, 5326.92009619856, 5330.333708286465, 5331.573474122061, 5792.9710351447975, 5805.593608447368, 5863.677497737665, 5867.3839246879315, 5874.148248503943, 5307.734613269398, 5316.441773613792, 5320.52115309624, 5322.175062865262, 5323.254744335796, 5480.177973304037, 5644.040513112863, 5650.095984642602, 5652.576056795675, 5654.773809047757, 5521.061419558604, 5521.861953451196, 5524.088525393426, 5528.944710552843, 5530.5022547970875, 5300.178472336794, 5310.097283461898, 5311.468853114658, 5311.973440132774, 5313.840584782462, 4056.290149223933, 4057.3711074783455, 4059.3910913363234, 4060.1067765091634, 4061.086255592468, 5499.450054994469, 5636.689982051026, 5645.266115405136, 5651.321841379061, 5657.321121465286, 5446.482584154499, 5454.10007348783, 5456.0, 5457.890842183055, 5471.343438787371, 5454.972725136349, 5457.918131227955, 5458.044842152687, 5463.7814487420055, 5467.398586155599, 5195.558377537952, 5346.358436987586, 5349.384820745664, 5417.918731219113, 5421.349438067457, 5298.761555730079, 5536.861578460571, 5543.279373681396, 5551.944480555143, 5553.278073850373, 5239.607029472729, 5248.1340578804065, 5342.439043900335, 5355.785768569213, 5423.186522021729], "unit": "score", "name": "prototype.html", "value": 4126.623644999069}, {"lowerIsBetter": false, "replicates": [651.6546230497836, 695.0339028750035, 724.5906063074362, 752.3680108708684, 755.6448469219469, 11531.48108335125, 11633.650990470289, 11693.064554835613, 11728.12039097068, 11728.765424691523, 11392.202545821776, 11564.826527602092, 11681.299122052662, 11763.470643821027, 11774.352410617412, 778.3267473635307, 790.6797746912509, 794.2772077409559, 794.7814351053478, 795.0, 759.1118391481951, 761.3110135327537, 761.8209720715628, 769.4767558060516, 775.3525805952037, 807.8465091632601, 809.9797505062392, 810.1614828652346, 810.7608255564593, 811.0308181722844, 804.899387576553, 806.7902345390212, 812.0255693168222, 813.3574476163853, 820.6922404098464, 609.0346800321496, 610.1457958857591, 611.8684482836212, 612.4120843989775, 613.6870196199925, 10465.68602941913, 10471.68584942453, 10482.0, 10502.002309780559, 10507.317024393466, 9717.56270967808, 9843.655472058443, 9894.10953014225, 9964.800703985953, 10106.949465252626, 8668.60991255395, 8824.161704638049, 10532.94733526335, 10646.680599581947, 10678.786424271471, 3888.241792850395, 3888.5333759948703, 3946.960530394688, 3947.2697550953167, 3954.7429417087797, 36409.27181456383, 37673.434898476546, 38317.616823831966, 41115.58884411147, 41276.174476510605, 9217.078292170729, 9232.446053236827, 9297.581608827619, 9342.673006444878, 9420.576074076545, 15360.923195383952, 15498.225088745743, 15507.844921550866, 15533.922330388275, 15972.920135399248, 6731.091302674076, 6779.525433219627, 6817.897731533932, 6860.245373008965, 6903.827404314932, 3480.912977175591, 3569.714422846166, 3646.070252085701, 3737.308597909341, 3742.7754334739457, 2618.77740392065, 2652.7214642462263, 2657.1895571850387, 2659.8005149613855, 2660.3881107345032, 492.3599320882838, 516.354556803995, 516.9689818610896, 528.5401700520572, 548.8490665067138, 413.4212103055686, 430.4210836425066, 439.5823967231143, 454.7680682851769, 554.3458718711959, 7273.963630181921, 7478.962605186939, 7529.962350188214, 7697.576633285223, 7715.729949451855, 446.6716963032169, 492.39435494341444, 523.8716514453984, 555.8860433611181, 576.0380165124252, 3388.6611338865914, 3647.8905632831056, 3867.2652196082654, 3999.34010888206, 4042.7978601070417, 40520.986975325264, 40535.797321013204, 40942.0, 42066.158676826904, 44502.55497445049, 35226.11934701653, 35654.108647284025, 37202.25595488129, 37339.626603734156, 37436.0, 37586.62413375831, 40752.0, 40884.79557602193, 41290.38064429036, 41831.58168418338, 7864.606769661608, 8016.839663206587, 8030.879536806836, 8047.798805029921, 8289.253967142986, 28099.578506322014, 29019.12942611725, 29071.0, 29274.56088158722, 29424.705752942198, 36341.0, 36568.63431365652, 37288.627113728515, 37498.8125059373, 37612.2477550442, 9214.216791572791, 9384.0, 9843.655472058443, 10262.640807571699, 10567.0, 10623.521941512496, 10632.681019569425, 10676.359418434608, 10807.67576972692, 11275.887241127484, 10475.742910850746, 10690.198235132551, 10745.892541074802, 10904.836427453753, 11175.608853690082, 10489.52797124116, 10548.367097974146, 10565.101966332948, 10798.622048228275, 11129.109671226444, 10638.14894808398, 10787.083097936764, 10793.892061079288, 10968.341899486057, 11113.0, 8094.31198348147, 8182.0, 8526.658933642584, 8582.313414926915, 8685.8697119542, 8351.582420879053, 8766.342524310574, 8780.121987801169, 8823.823523529365, 8971.596278167368], "unit": "score", "name": "yui.html", "value": 5559.193203512909}], "name": "dromaeo_css", "value": 5946.842907490266}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 111.0, 113.0, 115.0, 114.0, 105.0, 114.0, 114.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [163.0, 139.0, 165.0, 178.0, 133.0, 157.0, 161.0, 130.0, 171.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 164.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 100.0, 92.0, 72.0, 73.0, 73.0, 107.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.0}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 138.0, 97.0, 98.0, 97.0, 147.0, 97.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 146.0, 148.0, 147.0, 148.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 77.0, 65.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 67.2}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 84.0, 88.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 119.0, 125.0, 122.0, 126.0, 120.0, 126.0, 135.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [149.0, 136.0, 148.0, 145.0, 149.0, 139.0, 147.0, 149.0, 147.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 71.0, 70.0, 72.0, 71.0, 73.0, 70.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1532.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.78523489932886], "unit": "score", "name": "Richards", "value": 210.39992}, {"lowerIsBetter": false, "replicates": [190.11406844106463], "unit": "score", "name": "DeltaBlue", "value": 347.7806799999999}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [813.0081300813008], "unit": "score", "name": "Earley", "value": 819.7494899999999}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [44717.391304347824], "unit": "score", "name": "RegExp", "value": 20.37205153135634}, {"lowerIsBetter": false, "replicates": [600.9615384615385], "unit": "score", "name": "Splay", "value": 135.60102399999994}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 18704.18593211113}]} 07:24:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "18704.19"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1532.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5946.84"}}} 07:24:18 INFO - Return code: 0 07:24:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:24:18 INFO - # TBPL SUCCESS # 07:24:18 INFO - Running post-action listener: _resource_record_post_action 07:24:18 INFO - Running post-run listener: _resource_record_post_run 07:24:19 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 320225280; Read time: 0; Write time: 188408 07:24:19 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 15982592; Read time: 0; Write time: 3280 07:24:19 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 304242688; Read time: 0; Write time: 185128 07:24:19 INFO - Running post-run listener: _upload_blobber_files 07:24:19 INFO - Blob upload gear active. 07:24:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:24:19 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 07:24:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:24:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:24:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:20 INFO - (blobuploader) - INFO - Done attempting. 07:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:24:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:24:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:24:21 INFO - (blobuploader) - INFO - Done attempting. 07:24:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:24:21 INFO - Return code: 0 07:24:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:24:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:24:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfbcfbee8d1284aef3f54d3df2f5372e913d1769c3ecbccf809077c73a635640752ac2ec4ad04ccc6335f16e34f42c7dfd93b111bcce63a54833d1d20d174b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2988bb3c8ba4bca6471671716d779ec45db8ca571ff89afcb6ee0f49b5c858ab23a5227e7a13ec3616f97a056f7a290a5974fdb246b276abda459d3bd5e0ab9d"} 07:24:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:24:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:24:21 INFO - Contents: 07:24:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfbcfbee8d1284aef3f54d3df2f5372e913d1769c3ecbccf809077c73a635640752ac2ec4ad04ccc6335f16e34f42c7dfd93b111bcce63a54833d1d20d174b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2988bb3c8ba4bca6471671716d779ec45db8ca571ff89afcb6ee0f49b5c858ab23a5227e7a13ec3616f97a056f7a290a5974fdb246b276abda459d3bd5e0ab9d"} 07:24:21 INFO - Copying logs to upload dir... 07:24:21 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1589.909819 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 26 mins, 29 secs) (at 2016-01-13 07:24:20.820620) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:24:20.823882) ========= 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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfbcfbee8d1284aef3f54d3df2f5372e913d1769c3ecbccf809077c73a635640752ac2ec4ad04ccc6335f16e34f42c7dfd93b111bcce63a54833d1d20d174b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2988bb3c8ba4bca6471671716d779ec45db8ca571ff89afcb6ee0f49b5c858ab23a5227e7a13ec3616f97a056f7a290a5974fdb246b276abda459d3bd5e0ab9d"} build_url:https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/Lb_GB7oiSDGO29x_IaM_Xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8dfbcfbee8d1284aef3f54d3df2f5372e913d1769c3ecbccf809077c73a635640752ac2ec4ad04ccc6335f16e34f42c7dfd93b111bcce63a54833d1d20d174b0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2988bb3c8ba4bca6471671716d779ec45db8ca571ff89afcb6ee0f49b5c858ab23a5227e7a13ec3616f97a056f7a290a5974fdb246b276abda459d3bd5e0ab9d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 07:24:20.848306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:24:20.848640) ========= 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=0e2a256762fed810e2f0f810000001b3-1452689231.660314-1579334383 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 07:24:20.931310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:24:20.931651) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 07:24:20.931941) ========= ========= Total master_lag: 0.26 =========