builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1452687870.29 results: success (0) buildid: 20160113030032 builduid: 34a46952d24f4a34a08a9f77f46225eb revision: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.289483) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.290074) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.290362) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006510 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.318743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.319012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.349313) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.349595) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004572 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.397974) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.398275) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.398619) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.398901) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:24:30-- 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% 43.8M=0s 2016-01-13 04:24:30 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.148496 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.561668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.561956) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022875 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.612068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:30.612378) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --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 cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 --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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:24:30,698 truncating revision to first 12 chars 2016-01-13 04:24:30,698 Setting DEBUG logging. 2016-01-13 04:24:30,698 attempt 1/10 2016-01-13 04:24:30,698 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cae1c805bf91?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:24:30,975 unpacking tar archive at: fx-team-cae1c805bf91/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582553 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.207974) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.208350) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.220137) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.220432) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:24:31.220856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-13 04:24:31.221174) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:31 INFO - MultiFileLogger online at 20160113 04:24:31 in /builds/slave/test 04:24:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 04:24:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:31 INFO - {'append_to_log': False, 04:24:31 INFO - 'base_work_dir': '/builds/slave/test', 04:24:31 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:24:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:31 INFO - 'branch': 'Fx-Team-Non-PGO', 04:24:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:31 INFO - 'config_files': ('talos/linux_config.py',), 04:24:31 INFO - 'default_actions': ('clobber', 04:24:31 INFO - 'read-buildbot-config', 04:24:31 INFO - 'download-and-extract', 04:24:31 INFO - 'populate-webroot', 04:24:31 INFO - 'create-virtualenv', 04:24:31 INFO - 'install', 04:24:31 INFO - 'run-tests'), 04:24:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:31 INFO - 'download_minidump_stackwalk': True, 04:24:31 INFO - 'download_symbols': 'ondemand', 04:24:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:31 INFO - 'installer_path': 'installer.exe', 04:24:31 INFO - 'log_level': 'info', 04:24:31 INFO - 'log_name': 'talos', 04:24:31 INFO - 'log_to_console': True, 04:24:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:31 INFO - 'opt_config_files': (), 04:24:31 INFO - 'pip_index': False, 04:24:31 INFO - 'sps_profile': False, 04:24:31 INFO - 'sps_profile_interval': 0, 04:24:31 INFO - 'suite': 'dromaeojs-e10s', 04:24:31 INFO - 'system_bits': '32', 04:24:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:31 INFO - 'title': 'talos-linux64-ix-008', 04:24:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:31 INFO - 'use_talos_json': True, 04:24:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:31 INFO - 'work_dir': 'build'} 04:24:31 INFO - ##### 04:24:31 INFO - ##### Running clobber step. 04:24:31 INFO - ##### 04:24:31 INFO - Running pre-action listener: _resource_record_pre_action 04:24:31 INFO - Running main action method: clobber 04:24:31 INFO - rmtree: /builds/slave/test/build 04:24:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:31 INFO - Running post-action listener: _resource_record_post_action 04:24:31 INFO - ##### 04:24:31 INFO - ##### Running read-buildbot-config step. 04:24:31 INFO - ##### 04:24:31 INFO - Running pre-action listener: _resource_record_pre_action 04:24:31 INFO - Running main action method: read_buildbot_config 04:24:31 INFO - Using buildbot properties: 04:24:31 INFO - { 04:24:31 INFO - "project": "", 04:24:31 INFO - "product": "firefox", 04:24:31 INFO - "script_repo_revision": "production", 04:24:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:24:31 INFO - "repository": "", 04:24:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 04:24:31 INFO - "buildid": "20160113030032", 04:24:31 INFO - "pgo_build": "False", 04:24:31 INFO - "basedir": "/builds/slave/test", 04:24:31 INFO - "buildnumber": 683, 04:24:31 INFO - "slavename": "talos-linux64-ix-008", 04:24:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:24:31 INFO - "platform": "ubuntu64_hw", 04:24:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:24:31 INFO - "branch": "fx-team", 04:24:31 INFO - "repo_path": "integration/fx-team", 04:24:31 INFO - "revision": "cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56", 04:24:31 INFO - "stage_platform": "linux64", 04:24:31 INFO - "builduid": "34a46952d24f4a34a08a9f77f46225eb", 04:24:31 INFO - "slavebuilddir": "test" 04:24:31 INFO - } 04:24:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:24:31 INFO - Running post-action listener: _resource_record_post_action 04:24:31 INFO - ##### 04:24:31 INFO - ##### Running download-and-extract step. 04:24:31 INFO - ##### 04:24:31 INFO - Running pre-action listener: _resource_record_pre_action 04:24:31 INFO - Running main action method: download_and_extract 04:24:31 INFO - mkdir: /builds/slave/test/build/tests 04:24:31 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')]} 04:24:31 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:24:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json 04:24:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json 04:24:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:24:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:24:36 INFO - Downloaded 1448 bytes. 04:24:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:24:36 INFO - Using the following test package requirements: 04:24:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:36 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:24:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'jsshell-linux-x86_64.zip'], 04:24:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24: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')]} 04:24:36 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:40 INFO - Downloaded 22760804 bytes. 04:24:40 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 04:24:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:40 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 04:24:41 INFO - Return code: 0 04:24:41 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 04:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:24:41 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:46 INFO - Downloaded 22760804 bytes. 04:24:46 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 04:24:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:24:46 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 04:24:48 INFO - Return code: 0 04:24:48 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')]} 04:24:48 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:24:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:50 INFO - Downloaded 11132279 bytes. 04:24:50 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 04:24:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:50 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 04:24:50 INFO - Return code: 0 04:24:50 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')]} 04:24:50 INFO - https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:24:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:24:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:24:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R7B95WoPSWSa1w0EpH2WcQ/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 04:25:02 INFO - Downloaded 53904425 bytes. 04:25:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:25:02 INFO - mkdir: /builds/slave/test/properties 04:25:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:25:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:25:02 INFO - Contents: 04:25:02 INFO - build_url:https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:25:02 INFO - Running post-action listener: _resource_record_post_action 04:25:02 INFO - Running post-action listener: set_extra_try_arguments 04:25:02 INFO - ##### 04:25:02 INFO - ##### Running populate-webroot step. 04:25:02 INFO - ##### 04:25:02 INFO - Running pre-action listener: _resource_record_pre_action 04:25:02 INFO - Running main action method: populate_webroot 04:25:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:25:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:25:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:25:02 INFO - '--tppagecycles', 04:25:02 INFO - '7'], 04:25:02 INFO - 'tests': ['tsvgm']}}, 04:25:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:25:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:25:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:25:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:25:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:25:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'tests': ['damp', 'tps']}, 04:25:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['damp', 'tps']}, 04:25:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:25:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:25:02 INFO - 'other': {'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'other_l64': {'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'other_nol64': {'tests': ['a11yr', 04:25:02 INFO - 'ts_paint', 04:25:02 INFO - 'tpaint', 04:25:02 INFO - 'sessionrestore', 04:25:02 INFO - 'sessionrestore_no_auto_restore']}, 04:25:02 INFO - 'svgr': {'tests': ['tsvgx', 04:25:02 INFO - 'tsvgr_opacity', 04:25:02 INFO - 'tart', 04:25:02 INFO - 'tscrollx', 04:25:02 INFO - 'cart']}, 04:25:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['tsvgx', 04:25:02 INFO - 'tsvgr_opacity', 04:25:02 INFO - 'tart', 04:25:02 INFO - 'tscrollx', 04:25:02 INFO - 'cart']}, 04:25:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'tests': ['tp5o']}, 04:25:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'talos_options': ['--e10s'], 04:25:02 INFO - 'tests': ['tp5o']}, 04:25:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'talos_options': ['--xperf_path', 04:25:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:02 INFO - 'tests': ['tp5n']}, 04:25:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:25:02 INFO - 'talos_options': ['--e10s', 04:25:02 INFO - '--xperf_path', 04:25:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:25:02 INFO - 'tests': ['tp5n']}}, 04:25:02 INFO - 'talos.zip': {'path': '', 04:25:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:25:02 INFO - Running post-action listener: _resource_record_post_action 04:25:02 INFO - ##### 04:25:02 INFO - ##### Running create-virtualenv step. 04:25:02 INFO - ##### 04:25:02 INFO - Running pre-action listener: _resource_record_pre_action 04:25:02 INFO - Running main action method: create_virtualenv 04:25:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:25:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:25:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:25:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:25:02 INFO - Using real prefix '/usr' 04:25:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:25:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:25:05 INFO - Installing pip.................done. 04:25:05 INFO - Return code: 0 04:25:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:05 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 04:25:05 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 04:25:05 INFO - Using env: {'DISPLAY': ':0', 04:25:05 INFO - 'HOME': '/home/cltbld', 04:25:05 INFO - 'LANG': 'en_US.UTF-8', 04:25:05 INFO - 'LANGUAGE': 'en_US:en', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MAIL': '/var/mail/cltbld', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SHLVL': '1', 04:25:05 INFO - 'TERM': 'linux', 04:25:05 INFO - 'TMOUT': '86400', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - '_': '/tools/buildbot/bin/python'} 04:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:25:05 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:05 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 04:25:05 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 04:25:05 INFO - Using env: {'DISPLAY': ':0', 04:25:05 INFO - 'HOME': '/home/cltbld', 04:25:05 INFO - 'LANG': 'en_US.UTF-8', 04:25:05 INFO - 'LANGUAGE': 'en_US:en', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MAIL': '/var/mail/cltbld', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SHLVL': '1', 04:25:05 INFO - 'TERM': 'linux', 04:25:05 INFO - 'TMOUT': '86400', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - '_': '/tools/buildbot/bin/python'} 04:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:05 INFO - Downloading/unpacking psutil>=0.7.1 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:25:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:07 INFO - Installing collected packages: psutil 04:25:07 INFO - Running setup.py install for psutil 04:25:07 INFO - building 'psutil._psutil_linux' extension 04:25:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:25:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:25:07 INFO - building 'psutil._psutil_posix' extension 04:25:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:25:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:25:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:08 INFO - Successfully installed psutil 04:25:08 INFO - Cleaning up... 04:25:08 INFO - Return code: 0 04:25:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:08 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:08 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 04:25:08 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 04:25:08 INFO - Using env: {'DISPLAY': ':0', 04:25:08 INFO - 'HOME': '/home/cltbld', 04:25:08 INFO - 'LANG': 'en_US.UTF-8', 04:25:08 INFO - 'LANGUAGE': 'en_US:en', 04:25:08 INFO - 'LOGNAME': 'cltbld', 04:25:08 INFO - 'MAIL': '/var/mail/cltbld', 04:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:08 INFO - 'MOZ_NO_REMOTE': '1', 04:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:08 INFO - 'NO_EM_RESTART': '1', 04:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:08 INFO - 'PWD': '/builds/slave/test', 04:25:08 INFO - 'SHELL': '/bin/bash', 04:25:08 INFO - 'SHLVL': '1', 04:25:08 INFO - 'TERM': 'linux', 04:25:08 INFO - 'TMOUT': '86400', 04:25:08 INFO - 'USER': 'cltbld', 04:25:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:08 INFO - '_': '/tools/buildbot/bin/python'} 04:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:25:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:25:10 INFO - Installing collected packages: mozsystemmonitor 04:25:10 INFO - Running setup.py install for mozsystemmonitor 04:25:10 INFO - Successfully installed mozsystemmonitor 04:25:10 INFO - Cleaning up... 04:25:10 INFO - Return code: 0 04:25:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25: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')]} 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25: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')]} 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:10 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:10 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 04:25:10 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 04:25:10 INFO - Using env: {'DISPLAY': ':0', 04:25:10 INFO - 'HOME': '/home/cltbld', 04:25:10 INFO - 'LANG': 'en_US.UTF-8', 04:25:10 INFO - 'LANGUAGE': 'en_US:en', 04:25:10 INFO - 'LOGNAME': 'cltbld', 04:25:10 INFO - 'MAIL': '/var/mail/cltbld', 04:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:10 INFO - 'MOZ_NO_REMOTE': '1', 04:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:10 INFO - 'NO_EM_RESTART': '1', 04:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:10 INFO - 'PWD': '/builds/slave/test', 04:25:10 INFO - 'SHELL': '/bin/bash', 04:25:10 INFO - 'SHLVL': '1', 04:25:10 INFO - 'TERM': 'linux', 04:25:10 INFO - 'TMOUT': '86400', 04:25:10 INFO - 'USER': 'cltbld', 04:25:10 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:10 INFO - '_': '/tools/buildbot/bin/python'} 04:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - Downloading docopt-0.6.1.tar.gz 04:25:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:12 INFO - Running setup.py install for blobuploader 04:25:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:12 INFO - Running setup.py install for requests 04:25:13 INFO - Running setup.py install for docopt 04:25:13 INFO - Successfully installed blobuploader requests docopt 04:25:13 INFO - Cleaning up... 04:25:13 INFO - Return code: 0 04:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:13 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:13 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 04:25:13 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 04:25:13 INFO - Using env: {'DISPLAY': ':0', 04:25:13 INFO - 'HOME': '/home/cltbld', 04:25:13 INFO - 'LANG': 'en_US.UTF-8', 04:25:13 INFO - 'LANGUAGE': 'en_US:en', 04:25:13 INFO - 'LOGNAME': 'cltbld', 04:25:13 INFO - 'MAIL': '/var/mail/cltbld', 04:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:13 INFO - 'MOZ_NO_REMOTE': '1', 04:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:13 INFO - 'NO_EM_RESTART': '1', 04:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:13 INFO - 'PWD': '/builds/slave/test', 04:25:13 INFO - 'SHELL': '/bin/bash', 04:25:13 INFO - 'SHLVL': '1', 04:25:13 INFO - 'TERM': 'linux', 04:25:13 INFO - 'TMOUT': '86400', 04:25:13 INFO - 'USER': 'cltbld', 04:25:13 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:13 INFO - '_': '/tools/buildbot/bin/python'} 04:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:13 INFO - Running setup.py (path:/tmp/pip-5lTZYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:13 INFO - Running setup.py (path:/tmp/pip-tIbw70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:13 INFO - Running setup.py (path:/tmp/pip-BB4nUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:13 INFO - Running setup.py (path:/tmp/pip-7iwt6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:13 INFO - Running setup.py (path:/tmp/pip-Naj7Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:14 INFO - Running setup.py (path:/tmp/pip-0ZmLGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:14 INFO - Running setup.py (path:/tmp/pip-5AAfU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:14 INFO - Running setup.py (path:/tmp/pip-OhJEbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:14 INFO - Running setup.py (path:/tmp/pip-mt7vwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:14 INFO - Running setup.py (path:/tmp/pip-GNQEvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:14 INFO - Running setup.py (path:/tmp/pip-Bhd4Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:14 INFO - Running setup.py (path:/tmp/pip-09vEJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:14 INFO - Running setup.py (path:/tmp/pip-TYk_TT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:14 INFO - Running setup.py (path:/tmp/pip-_i9iKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:14 INFO - Running setup.py (path:/tmp/pip-iXjNZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:14 INFO - Running setup.py (path:/tmp/pip-cFYrkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:14 INFO - Running setup.py (path:/tmp/pip-3hjv1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:14 INFO - Running setup.py install for manifestparser 04:25:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for mozcrash 04:25:15 INFO - Running setup.py install for mozdebug 04:25:15 INFO - Running setup.py install for mozdevice 04:25:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for mozfile 04:25:15 INFO - Running setup.py install for mozhttpd 04:25:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for mozinfo 04:25:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for mozInstall 04:25:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for mozleak 04:25:15 INFO - Running setup.py install for mozlog 04:25:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:15 INFO - Running setup.py install for moznetwork 04:25:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Running setup.py install for mozprocess 04:25:16 INFO - Running setup.py install for mozprofile 04:25:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Running setup.py install for mozrunner 04:25:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Running setup.py install for mozscreenshot 04:25:16 INFO - Running setup.py install for moztest 04:25:16 INFO - Running setup.py install for mozversion 04:25:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:16 INFO - Cleaning up... 04:25:16 INFO - Return code: 0 04:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:16 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:16 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 04:25:16 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 04:25:16 INFO - Using env: {'DISPLAY': ':0', 04:25:16 INFO - 'HOME': '/home/cltbld', 04:25:16 INFO - 'LANG': 'en_US.UTF-8', 04:25:16 INFO - 'LANGUAGE': 'en_US:en', 04:25:16 INFO - 'LOGNAME': 'cltbld', 04:25:16 INFO - 'MAIL': '/var/mail/cltbld', 04:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:16 INFO - 'MOZ_NO_REMOTE': '1', 04:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:16 INFO - 'NO_EM_RESTART': '1', 04:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:16 INFO - 'PWD': '/builds/slave/test', 04:25:16 INFO - 'SHELL': '/bin/bash', 04:25:16 INFO - 'SHLVL': '1', 04:25:16 INFO - 'TERM': 'linux', 04:25:16 INFO - 'TMOUT': '86400', 04:25:16 INFO - 'USER': 'cltbld', 04:25:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:16 INFO - '_': '/tools/buildbot/bin/python'} 04:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:16 INFO - Running setup.py (path:/tmp/pip-eOMZ1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:16 INFO - Running setup.py (path:/tmp/pip-495FBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:17 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)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:17 INFO - Running setup.py (path:/tmp/pip-9LnysF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:17 INFO - Running setup.py (path:/tmp/pip-2enVQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:17 INFO - Running setup.py (path:/tmp/pip-UF5Oa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:17 INFO - Running setup.py (path:/tmp/pip-nCtZSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:17 INFO - Running setup.py (path:/tmp/pip-dXiIF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:17 INFO - Running setup.py (path:/tmp/pip-gK_v3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:17 INFO - Running setup.py (path:/tmp/pip-53aEOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:17 INFO - Running setup.py (path:/tmp/pip-fuUBVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:17 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)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:17 INFO - Running setup.py (path:/tmp/pip-LVmAjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:17 INFO - Running setup.py (path:/tmp/pip-DJncYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:17 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)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:17 INFO - Running setup.py (path:/tmp/pip-LWHSJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:17 INFO - Running setup.py (path:/tmp/pip-HixQzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:17 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)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:17 INFO - Running setup.py (path:/tmp/pip-_vnVbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:17 INFO - Running setup.py (path:/tmp/pip-dZvQFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:18 INFO - Running setup.py (path:/tmp/pip-HyUxRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:18 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)) 04:25:18 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)) 04:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:19 INFO - Downloading blessings-1.5.1.tar.gz 04:25:19 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 04:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:19 INFO - Installing collected packages: blessings 04:25:19 INFO - Running setup.py install for blessings 04:25:20 INFO - Successfully installed blessings 04:25:20 INFO - Cleaning up... 04:25:20 INFO - Return code: 0 04:25:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:20 INFO - Reading from file tmpfile_stdout 04:25:20 INFO - Current package versions: 04:25:20 INFO - argparse == 1.2.1 04:25:20 INFO - blessings == 1.5.1 04:25:20 INFO - blobuploader == 1.2.4 04:25:20 INFO - docopt == 0.6.1 04:25:20 INFO - manifestparser == 1.1 04:25:20 INFO - mozInstall == 1.12 04:25:20 INFO - mozcrash == 0.16 04:25:20 INFO - mozdebug == 0.1 04:25:20 INFO - mozdevice == 0.48 04:25:20 INFO - mozfile == 1.2 04:25:20 INFO - mozhttpd == 0.7 04:25:20 INFO - mozinfo == 0.9 04:25:20 INFO - mozleak == 0.1 04:25:20 INFO - mozlog == 3.1 04:25:20 INFO - moznetwork == 0.27 04:25:20 INFO - mozprocess == 0.22 04:25:20 INFO - mozprofile == 0.28 04:25:20 INFO - mozrunner == 6.11 04:25:20 INFO - mozscreenshot == 0.1 04:25:20 INFO - mozsystemmonitor == 0.0 04:25:20 INFO - moztest == 0.7 04:25:20 INFO - mozversion == 1.4 04:25:20 INFO - psutil == 3.1.1 04:25:20 INFO - requests == 1.2.3 04:25:20 INFO - wsgiref == 0.1.2 04:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:20 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 04:25:20 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 04:25:20 INFO - Using env: {'DISPLAY': ':0', 04:25:20 INFO - 'HOME': '/home/cltbld', 04:25:20 INFO - 'LANG': 'en_US.UTF-8', 04:25:20 INFO - 'LANGUAGE': 'en_US:en', 04:25:20 INFO - 'LOGNAME': 'cltbld', 04:25:20 INFO - 'MAIL': '/var/mail/cltbld', 04:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:20 INFO - 'MOZ_NO_REMOTE': '1', 04:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:20 INFO - 'NO_EM_RESTART': '1', 04:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:20 INFO - 'PWD': '/builds/slave/test', 04:25:20 INFO - 'SHELL': '/bin/bash', 04:25:20 INFO - 'SHLVL': '1', 04:25:20 INFO - 'TERM': 'linux', 04:25:20 INFO - 'TMOUT': '86400', 04:25:20 INFO - 'USER': 'cltbld', 04:25:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:20 INFO - '_': '/tools/buildbot/bin/python'} 04:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:20 INFO - Cleaning up... 04:25:20 INFO - Return code: 0 04:25:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:20 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:20 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 04:25:20 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 04:25:20 INFO - Using env: {'DISPLAY': ':0', 04:25:20 INFO - 'HOME': '/home/cltbld', 04:25:20 INFO - 'LANG': 'en_US.UTF-8', 04:25:20 INFO - 'LANGUAGE': 'en_US:en', 04:25:20 INFO - 'LOGNAME': 'cltbld', 04:25:20 INFO - 'MAIL': '/var/mail/cltbld', 04:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:20 INFO - 'MOZ_NO_REMOTE': '1', 04:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:20 INFO - 'NO_EM_RESTART': '1', 04:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:20 INFO - 'PWD': '/builds/slave/test', 04:25:20 INFO - 'SHELL': '/bin/bash', 04:25:20 INFO - 'SHLVL': '1', 04:25:20 INFO - 'TERM': 'linux', 04:25:20 INFO - 'TMOUT': '86400', 04:25:20 INFO - 'USER': 'cltbld', 04:25:20 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:20 INFO - '_': '/tools/buildbot/bin/python'} 04:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:20 INFO - Downloading/unpacking jsonschema 04:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:22 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 04:25:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:22 INFO - warning: no files found matching '*.txt' 04:25:22 INFO - no previously-included directories found matching 'build' 04:25:22 INFO - no previously-included directories found matching 'dist' 04:25:22 INFO - no previously-included directories found matching '.git*' 04:25:22 INFO - Installing collected packages: jsonschema, functools32 04:25:22 INFO - Running setup.py install for functools32 04:25:22 INFO - warning: no files found matching '*.txt' 04:25:22 INFO - no previously-included directories found matching 'build' 04:25:22 INFO - no previously-included directories found matching 'dist' 04:25:22 INFO - no previously-included directories found matching '.git*' 04:25:22 INFO - Successfully installed jsonschema functools32 04:25:22 INFO - Cleaning up... 04:25:22 INFO - Return code: 0 04:25:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:22 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')]} 04:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:22 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')]} 04:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:22 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 0x7f344a200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e0dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, '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': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:22 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 04:25:22 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 04:25:22 INFO - Using env: {'DISPLAY': ':0', 04:25:22 INFO - 'HOME': '/home/cltbld', 04:25:22 INFO - 'LANG': 'en_US.UTF-8', 04:25:22 INFO - 'LANGUAGE': 'en_US:en', 04:25:22 INFO - 'LOGNAME': 'cltbld', 04:25:22 INFO - 'MAIL': '/var/mail/cltbld', 04:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:22 INFO - 'MOZ_NO_REMOTE': '1', 04:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:22 INFO - 'NO_EM_RESTART': '1', 04:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:22 INFO - 'PWD': '/builds/slave/test', 04:25:22 INFO - 'SHELL': '/bin/bash', 04:25:22 INFO - 'SHLVL': '1', 04:25:22 INFO - 'TERM': 'linux', 04:25:22 INFO - 'TMOUT': '86400', 04:25:22 INFO - 'USER': 'cltbld', 04:25:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:22 INFO - '_': '/tools/buildbot/bin/python'} 04:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:23 INFO - Downloading/unpacking flake8 04:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:24 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 04:25:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:25 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 04:25:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:25 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 04:25:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:25:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:25 INFO - no previously-included directories found matching 'docs/_build' 04:25:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:25 INFO - Running setup.py install for pep8 04:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:25 INFO - no previously-included directories found matching 'docs/_build' 04:25:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:25 INFO - Cleaning up... 04:25:25 INFO - Return code: 0 04:25:25 INFO - Running post-action listener: _resource_record_post_action 04:25:25 INFO - Running post-action listener: _start_resource_monitoring 04:25:25 INFO - Starting resource monitoring. 04:25:25 INFO - ##### 04:25:25 INFO - ##### Running install step. 04:25:25 INFO - ##### 04:25:25 INFO - Running pre-action listener: _resource_record_pre_action 04:25:25 INFO - Running main action method: install 04:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:25 INFO - Reading from file tmpfile_stdout 04:25:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:26 INFO - Reading from file tmpfile_stdout 04:25:26 INFO - Output received: 04:25:26 INFO - Usage: mozinstall [options] installer 04:25:26 INFO - Options: 04:25:26 INFO - -h, --help show this help message and exit 04:25:26 INFO - -d DEST, --destination=DEST 04:25:26 INFO - Directory to install application into. [default: 04:25:26 INFO - "/builds/slave/test"] 04:25:26 INFO - --app=APP Application being installed. [default: firefox] 04:25:26 INFO - mkdir: /builds/slave/test/build/application 04:25:26 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'] 04:25:26 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 04:25:41 INFO - Reading from file tmpfile_stdout 04:25:41 INFO - Output received: 04:25:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:41 INFO - Running post-action listener: _resource_record_post_action 04:25:41 INFO - ##### 04:25:41 INFO - ##### Running run-tests step. 04:25:41 INFO - ##### 04:25:41 INFO - Running pre-action listener: _resource_record_pre_action 04:25:41 INFO - Running main action method: run_tests 04:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:41 INFO - Python 2.7.3 04:25:41 INFO - Return code: 0 04:25:41 INFO - grabbing minidump binary from tooltool 04:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:25:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11733d0>, '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 0x10deed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:25:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:41 INFO - Return code: 0 04:25:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:42 INFO - Return code: 0 04:25:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:25:42 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:25:42 INFO - Using env: {'DISPLAY': ':0', 04:25:42 INFO - 'HOME': '/home/cltbld', 04:25:42 INFO - 'LANG': 'en_US.UTF-8', 04:25:42 INFO - 'LANGUAGE': 'en_US:en', 04:25:42 INFO - 'LOGNAME': 'cltbld', 04:25:42 INFO - 'MAIL': '/var/mail/cltbld', 04:25:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:42 INFO - 'MOZ_NO_REMOTE': '1', 04:25:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:42 INFO - 'NO_EM_RESTART': '1', 04:25:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:42 INFO - 'PWD': '/builds/slave/test', 04:25:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:42 INFO - 'SHELL': '/bin/bash', 04:25:42 INFO - 'SHLVL': '1', 04:25:42 INFO - 'TERM': 'linux', 04:25:42 INFO - 'TMOUT': '86400', 04:25:42 INFO - 'USER': 'cltbld', 04:25:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387', 04:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:42 INFO - '_': '/tools/buildbot/bin/python'} 04:25:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:25:42 INFO - mozversion application_buildid: 20160113030032 04:25:42 INFO - mozversion application_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 04:25:42 INFO - mozversion application_display_name: Nightly 04:25:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:42 INFO - mozversion application_name: Firefox 04:25:42 INFO - mozversion application_remotingname: firefox 04:25:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:25:42 INFO - mozversion application_vendor: Mozilla 04:25:42 INFO - mozversion application_version: 46.0a1 04:25:42 INFO - mozversion platform_buildid: 20160113030032 04:25:42 INFO - mozversion platform_changeset: cae1c805bf9116cfb91d9e0f8b2496cfb37b1f56 04:25:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:25:42 INFO - mozversion platform_version: 46.0a1 04:25:42 INFO - using testdate: 1452687942 04:25:42 INFO - actual date: 1452687942 04:25:42 INFO - starting webserver on 'localhost:52908' 04:25:42 INFO - SUITE-START | Running 3 tests 04:25:42 INFO - TEST-START | dromaeo_css 04:25:42 INFO - operating with platform_type : linux_ 04:25:42 INFO - Initialising browser for dromaeo_css test... 04:25:42 INFO - TEST-INFO | started process 20150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvaU59/profile http://localhost:52908/getInfo.html) 04:25:47 INFO - PROCESS | 20150 | 04:25:47 INFO - PROCESS | 20150 | (process:20233): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:25:48 INFO - PROCESS | 20150 | __metrics Screen width/height:1600/1200 04:25:48 INFO - PROCESS | 20150 | colorDepth:24 04:25:48 INFO - PROCESS | 20150 | Browser inner width/height: 1024/697 04:25:48 INFO - PROCESS | 20150 | __metrics 04:25:48 INFO - PROCESS | 20150 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:49 INFO - TEST-INFO | 20150: exit 0 04:25:49 INFO - Browser initialized. 04:25:49 INFO - Running cycle 1/1 for dromaeo_css test... 04:25:49 INFO - TEST-INFO | started process 20282 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfvaU59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:25:50 INFO - PROCESS | 20282 | 04:25:50 INFO - PROCESS | 20282 | (process:20340): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:26:01 INFO - PROCESS | 20282 | RSS: Main: 150061056 04:26:01 INFO - PROCESS | 20282 | 04:26:50 INFO - PROCESS | 20282 | 1452688010843 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:29:02 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52908/tests/dromaeo/cssquery-ext.html) 04:29:03 INFO - PROCESS | 20282 | RSS: Main: 155058176 04:29:03 INFO - PROCESS | 20282 | 04:32:05 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-ext.html (next: http://localhost:52908/tests/dromaeo/cssquery-jquery.html) 04:32:06 INFO - PROCESS | 20282 | RSS: Main: 151703552 04:32:06 INFO - PROCESS | 20282 | 04:35:07 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52908/tests/dromaeo/cssquery-mootools.html) 04:35:08 INFO - PROCESS | 20282 | RSS: Main: 151187456 04:35:08 INFO - PROCESS | 20282 | 04:38:10 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52908/tests/dromaeo/cssquery-prototype.html) 04:38:10 INFO - PROCESS | 20282 | RSS: Main: 150724608 04:38:10 INFO - PROCESS | 20282 | 04:41:13 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52908/tests/dromaeo/cssquery-yui.html) 04:41:14 INFO - PROCESS | 20282 | RSS: Main: 150831104 04:41:14 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | Cycle 1(1): loaded http://localhost:52908/tests/dromaeo/cssquery-yui.html (next: http://localhost:52908/tests/dromaeo/cssquery-dojo.html) 04:44:16 INFO - PROCESS | 20282 | RSS: Main: 152920064 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | __start_tp_report 04:44:16 INFO - PROCESS | 20282 | _x_x_mozilla_page_load 04:44:16 INFO - PROCESS | 20282 | _x_x_mozilla_page_load_details 04:44:16 INFO - PROCESS | 20282 | |i|pagename|runs| 04:44:16 INFO - PROCESS | 20282 | |0;dojo.html;2628.106443809107;2652.1513115802945;2678.9330266743327;2684.516786978343;2705.6617922759656;4479.529649386808;4482.103579284144;4515.977420112903;4517.977410112949;4545.795439205235;4452.1986042512335;4464.508904020555;4548.067646132535;4570.223062079446;4655.557722016403;4157.667386609071;4187.413762073297;4236.724612900167;4240.512341080785;4277.74333539987;4205.179989901971;4224;4229.146445338035;4256.318988961767;4297.5057868345075;4153.958460415387;4228.302330115527;4240.342746874239;4277.935830962538;4289.592488713567;4179.059711564904;4197.685173611961;4198.769067701275;4261.509926358477;4278.4010238566625;4176.2900306947895;4182.1008483176265;4201.6008479194425;4215.430916826251;4218.557051509578;4283.507396649394;4448.621867141297;4451.931536431265;4456.64346852251;4499.3475945987975;4777.665563410563;4860.076585448789;4866.78099485524;4885.975570122162;4945.134601444733;4858.805647774085;4863.683860549053;4879.121758083544;4900.117978763821;4903.754812259408;4406.801693923781;4496.213162696515;4513.81944722214;4542.409486766732;4572.131295053962;4997.425296090996;5021.573166280834;5038.445770965191;5038.949610503922;5066.06277838601;4813.807447702123;4817.084753896748;4834.20235661112;4852.17513022787;4894.143524883202;4758.07217592573;4799.968006878468;4834.033193361342;4925.38432695913;4982;4803.975980120147;4829.710217386968;4837.975810120927;4848.951510484921;4880.682755620874;4811.230203167476;4817.301491283744;4824.396950381202;4831.855044348676;4877.170880950247;3986.4219688145636;4062.3906414037538;4064.898377540585;4072.063425412172;4074.5110586729784;3537.1334023163977;3559.893203203908;3560.1989552350515;3603.4594810778067;3604.0269127335473;4231.809568569422;4257.70196086271;4284.592963668447;4311.116221174651;4315.223259813264;4794.448638406628;4823.445303790038;4906.754662266872;4937.679050861682;4945.530174633404;4253.532111467736;4263.914721705611;4280.443542339476;4297.634701050383;4338.913221735547;4345.847895323648;4370.628496577763;4371.69398142127;4387.319965405367;4442.200403927324;4469.217886869785;4503.189425903369;4543.613792827647;4579.313103034571;4681.7425041622355;4921.040397122527;4932.728699921395;4953.083679519301;4965.851024469127;4981.726005069756;4597.770111494478;4647.55848194421;4650.302454631832;4650.697704649187;4670.462896766915;4698.624110071254;4747.454042785124;4772.665913386029;4802.303665968485;4824.155772739687;4908.312836202863;4909.459959404534;4920.901581968269;4940.876478087933;4984.2025275955675;4562.019165879352;4768.880777980439;4777.784999675093;4782.187028205144;4835;4657.953420465752;4673.509281525527;4692.366530518337;4705.458872229738;4732.6687131900435;4574.6569007323915;4579.35888975537;4579.793909274024;4606.930896036629;4653.930191047205;4670.1827180244;4699.788509517011;4718.528147185254;4764.237721964469;4773.618110551217;4694.084653492536;4705.7411842349;4708.058388322418;4730.408698912636;4766.237402015661 04:44:16 INFO - PROCESS | 20282 | |1;ext.html;500.69457630845176;506.2103119134151;515.4973900447062;534.2760559441957;551.9733296069313;32500.837495812517;32910.506342404886;33017.17457063575;33018.17454563634;33260.168495787555;35559.11102222446;36237;36335.003149653516;36421.45367819485;36497.81751091247;7696.769096927087;7810.828375743656;7813.726519571816;7820.726274580391;7850.175731548163;7605.277498637621;7714.07431108265;7720.806979825521;7723.343515801163;7786.065672119354;7871.9212807872045;7949.682012719484;7955.641996110189;7966.283034526891;7994.360451163893;7856.332211762007;7870.803229919241;7884.763457096296;7893.881591776128;7899.526028438312;7604.809879752995;7663.693452261903;7709;7716.652750626179;7766.650500727481;37367.62632373669;37766;37795.24409511822;37807.62192378069;37813.62186378156;2963.392504536565;2997.430488207234;3186.9840650796828;3270.3132342208164;3384.289299247161;28020.719792802218;28390;28461;28747.712522874714;28969.71030289691;3417.2482053948092;3501.6673416025437;3502.2120022994877;3532.6114127445962;3581.230035542371;203695;204113;204498.977505113;204618;204897;37996;54057;54184;54398.45601543934;54640.45359546433;35193.47209791855;35320;35435.11412214664;35573.1106722334;35670.464943025356;12559.309237991816;12623.431945562472;12741.17182383142;12772.425240864184;12819.807702884464;10153.289269751047;10185.134263587677;10185.745356366002;10211.336263142872;10236.283460157718;13153;13156.473741050442;13184.208947463183;13220.471181152647;13270.66823329405;5381.327334083239;5436.238926550286;5456.208849716769;5495.835124946258;5512.4211957744665;788.2708494642433;937.723371605378;939.1782190583103;998.8211125315264;1017.623479312659;25638;25831.225063248134;25852.8707356462;26094.608580871303;26273.868630656725;941.2140862379853;972.6528757670677;999.6504718629792;1004.4124187350482;1125.482278152043;13947;14951;15501.534953951399;15575.28671846096;15799.921000394925;304755;309369;310027;311231;312019.43990279903;47926.28110578344;48075.5192448078;48171;48495;48794.75602621964;1178.723000094977;1180.533689192764;1197.7484728207;1235.9196652217577;1236.2644226685109;27427;27835.44329113366;28084.737487170605;28396.85801570979;28520.85739571289;38013.239735205694;38484.230315392975;38544.80727596344;38574.42138367983;38796.41805372865;236749;237331;238818;239341;239357;29310.26724331909;29377.412451751272;29445;29534;29572.408551828412;38569.807150964065;38578.80710596541;38784;39133.804330978164;39472.802635986634;32596.83701581477;32600;33131.668683312855;33335.83332083324;33804.83097584496;33231.667683322856;33511.66488335183;33891.32217355688;33924.83037584796;34162.31675366429;35003.64996350004;35110.297794043465;35225.64774352223;35440.29119417649;35528.289434211685;28440.715592843808;28513.42973140567;30460.695393045786;30570.541441878835;30589.23526911845;23262.626919096976;23270.534589308456;23745.52508949846;23771.40571485727;23823.52352952966 04:44:16 INFO - PROCESS | 20282 | |2;jquery.html;340.99318013639726;345.6232706350079;346.4716307630863;348.1036331446524;351.16598079561044;13930.930345348272;14196.290185490723;14775.187364694964;15470;16429;10256.948715256412;10588.629397971072;12791.784780445843;15433.614159645986;15458.07251564907;4426.203283408985;4447.0661161156195;4590.862274131765;4693.436787585478;4706.882327941795;4596.678232523725;4660.906781864361;4672.252439609663;4674.602658773992;4693.929591056137;4526.660500462462;4660.37084993525;5732.283464566929;5996.370381109986;5999.820005399845;5930.822075337746;6062.151298818169;6075.726592303357;6340.3659634036685;6383.585066970679;6047.5766696331275;6073.757049718006;6082.756689732405;6085.452309292141;6102.359252278536;19060.61878762417;19185.616287674307;19623.705644415346;20499.18003279867;20537.075831587616;1879.370410912346;1946.698261769428;1951.7853036166011;2007.7691065527506;2051.8768873867616;13006.739865202737;13038.152520086163;13199.472021119143;13242.404091815892;13256.20462772227;1823.5714607067328;1846.1507706455047;1850.4633656239675;1881.2663061405926;1883.6326916251337;56169.43830561683;56985.14522282169;57819.42180578182;57912.710436447545;58994.70502647459;14153.433862645585;14518.709625807425;14628.268586570628;14673.633159171106;14729.631759206106;21475.785242147693;21963;22009.779902200775;22024.44938876509;22058;8393.790155246046;8417.747467575982;8431;8467.745967620982;8506.89410376647;7100.751473698396;7102.325279098477;7142.821429464305;7164.319389657974;7174.210836807947;7124.109486314211;7194.532355396883;7229;7250.4199664026755;7370.852582948418;1747.7028905086165;1815.3918437323644;2907.25864904448;3098.598586095749;3125.24994001438;778.7261197303774;788.787027502571;885.8051228729669;915.0072171693654;962.9807403851884;15079.773803392958;15612.609684757972;15934.36262549485;16059.277332520065;16085.276162572713;852.318145483623;874.5539774714941;889.4574309671225;909.6907051602487;954.7565370830393;8687.218150366498;8783.516906570072;8870.556472176366;8901.685323537391;8989.146031127033;420518;425568;441409;441582;441683;61766.69116654478;62587.68706156531;64030;64085;64918.35081649217;1079.2984560036039;1083.6369816111533;1096.199774164864;1109.1071687291808;1112.2881355932209;13302.334883255991;13375.130616509896;13664.590062298146;13736.038477306893;13968.231747253592;29542.852285738434;30125.849370753007;30334.544981825733;30625.693743062286;31337.373252534366;37336.81331593324;38592.2281554373;38899.80550097232;39442.802785985885;39464.40803388009;6598.307177746267;6713.597184168965;6720.1599800025;6721.563098398588;6928.16861976566;9224.35429519954;9573.324668183179;10150.695479135638;10218;10330.793384132425;8368.20502052304;8383.245507904074;8772.824543508967;8779.385443018928;8870.379073465054;9030.413023153475;9030.413023153475;9410.858837117587;9567.37812042215;9621.9037809621;8762.255208307366;8966.506842123747;9267.44395336282;9405.85891211646;9534.18959388432;6597.340265973557;6699.464042876656;6742.224644165984;6782.559133656297;6960.965195173992;7389.556626602421;7929.484583502054;8029.7189598363775;8051.2351326623875;8164.061132969785 04:44:16 INFO - PROCESS | 20282 | |3;mootools.html;1367.043069851104;1373.8626137386264;1480.348646595498;1666.4084250091225;1676.1619190404797;5869.266341707286;5974;6793.59238445693;7006.159260888688;7011.439084873211;6484.1894763154605;6612.702428390722;6656.068150458939;6702;6707.396334329909;2060.361288000721;2064.8967551622436;2082.635538780715;2083.781202973689;2086.5305306306113;2028.9898550507228;2059.927902523412;2062.6802845558964;2066.7209926659934;2072.4197224777013;2041.4896275931017;2044.325372627037;2049.8975051247453;2055.085486958304;2063.1231726516244;2002.8297594704468;2012.738344015276;2019.9091040903122;2021.9393418197478;2022.312413779322;2036.378904434147;2041.2345370486069;2065.0397565132134;2074.771775104737;2076.3355726167633;6914.654267286615;6920.238773734885;6938.375546200866;6939.895901561481;6951.582905025664;3997.960020399788;4127.153933443637;4130.78141948123;4139.79301034947;4155.688323375729;2720.2111387697546;2723.700392956793;2730.494858451193;2807.1718842941177;2831.6318878545862;853.9786505337354;866.9956650216772;902.3277658144658;918.678462538113;927.2581934452478;9169.495677737721;9279.304052196045;9321.487318197496;9324.766880827965;9346.485943273185;3689.2252626948107;3730.1607138393642;3738.8504459821847;3746.512953316106;3758.511393518825;7957.5225486471;8005.8398832024195;8045.0748163960725;8051.315638170704;8063.5968201589685;4119.670426365884;4120.237756015147;4120.546739858613;4131.35963925592;4155.750654960712;3195.408849362875;3267.232200432896;3661.7802931824176;3734.4398340248636;3776.754510956779;3231.563738895219;3269.6239932407602;3290.753193510496;3293.2425542125447;3305.338932213519;1013.2400699475394;1029.1252435429974;1029.9279050466396;1040.5109598488698;1040.5681642118436;922.1516205091198;926.5876684875166;930.418488444722;946.2666433514082;976.5751897924425;6493.123428337209;6513.1532900722605;6562.409383155444;6637.668116594247;6646.833829154213;1024.3904876598413;1029.9742506437399;1034.7568321444455;1035.4201647077662;1059.4120263253815;5080.060188865072;5110.744462776921;5127.282180494733;5141.28022076902;5175.585953123741;7904.446688731734;7927.5243485391065;8042.477238979564;8095.83808323842;8237.917620823835;8361.95819020901;8371.455855369382;8391.874121888177;8416.410851240355;8421.284190843848;6599.8020059398295;6615.338466153443;6664.83337916556;6689.096971908827;6723.294054124344;6246.46905013079;6345.746170153142;6397.616143031433;6421.550491465552;6431.1317972073175;7155.069840920647;7253.419726421768;7401.59291238987;7428.702851885864;7437.8140546486775;7480.326770590673;7678.1937896522295;7690.154083050748;7695.6921723130445;7697.191794861459;5066.08810414129;5177.8187763428095;6011.27864656244;6062.969685151546;6107.450329470369;5932.8813423732145;5999.5800293979;6037.63774173551;6046.90929636047;6056.6971651418135;5732.57005724564;5754.165645981393;5843.444872737083;5881.911771323348;5957.702114894151;5437.592180586393;5526.50261476469;5542.334919809648;5566.860828479321;5575.414581468887;5703.800366987136;5726.570507211893;5745.885082298414;5755.050416681201;5798.391168927371;5416.75624596902;5427.592930530305;5452.045891968969;5476.069068258326;5479.287692599936;5535.252740880091;5556.361018482765;5565.749541270734;5570.331560212639;5570.387257401763 04:44:16 INFO - PROCESS | 20282 | |4;prototype.html;281.56498210265147;293.17763672897524;297.5135653207007;310.8166181952649;314.49523514758795;5469.535089517396;5511.145772405283;5514.889702205954;5580.581456390772;5627.352854421742;5414.972925135378;5520.227168196456;5531.419200983889;5539.778408863641;5584.720763961806;4102.630763231324;4247.193033323674;4261.701680882339;4264.147170565884;4269.423627810237;4212.115455754295;4226.894327641803;4232.195882782277;4244.830206791725;4256;4231.153769246148;4232.851850185244;4233.111046680201;4243.366303972977;4243.618074373306;4212.768297743638;4222.662187025031;4227.309076369446;4234.597713217239;4247.660187185018;3655.780653160792;3670.376036073874;3672.5225720656413;3675.8529658813613;3678.2275722098393;5172.689638621657;5179.456157103526;5325.573954083664;5349.973250133763;5371.811986580451;4753.857384278477;4755.833545825914;4779.330893674888;4781.330613714083;4787.4494433139935;5821.09772985188;5853.941460585383;5856.590038697293;5857.26784151981;5862.443067908542;3829.0427393151713;3891.6692081173132;3899.5571638493657;3901.6683581895572;3903.941440878389;6070.301915279755;6087.147799308056;6120.632762034292;6121.387861213888;6125.785597504066;4030.1939612077704;4037.6567991720444;4039.1921615676983;4040.3333449980423;4044;4103.261412945699;4103.794810259535;4108.77401742901;4111.48606424197;4114.6091121343425;4782.0435912817575;4783.976080119577;4784.808607655725;4785.353977213032;4786.976065119652;5599.356074051455;5662.830115096472;5815.82552523425;5829.88340233193;5844.298684157843;1441.891858110646;1449.1884544655027;1451.7604595241878;1452.2158034661377;1452.3682198243798;957.9329446938787;960.4717405426987;961.1733908838394;974.3423189347162;979.7403688022537;5063.11395505785;5080.466551012164;5088.542031217208;5099.031184075014;5102;6036.5170786336985;6045.879082418415;6055.818325450244;6056.485198758067;6057.151998720183;5074.974625126851;5085.6948583084395;5087;5091.9236211456855;5094.847154585368;3201.4557525220766;3255.544223808669;3265.591801024872;3277.393682168806;3286.4248756467523;5608.495235428831;5648;5650.74571644277;5652.208690783212;5660.716964151776;6229.626222426669;6244.344343843922;6244.625322480666;6261.467775239155;6266.561340706198;5444.3194600674915;5586.413426590149;5625.099984002622;5632.85917852057;5660.122680984454;5993.190919225849;6025.66858822769;6026.90959635597;6038.033914573647;6038.63768173911;5863.618864773776;5894.233749612523;5913.497352725067;5914.58597898143;5929.762809487572;5608.747606357805;5633.63381380209;5636.267285252891;5665.433456654301;5675.0919852825;3994.6205110514456;4072.511298644182;4092.795360231917;4102.2000709861295;4103.835846566104;5970.253718285215;5979.820605381846;6029.698515074317;6031;6119.204503414706;5883.2057672215415;5919.082542205965;5920.111983202554;5923.259592550931;5935.970320148372;5909.172715819703;5913.526917846476;5970.462658360769;5980.790672326448;5993.850153746017;5653.802116925888;5787.826365209051;5795.623284486495;5801.3038435388025;5819.76720931158;5957.76168953237;5957.970210149095;5958.433948775033;5962.284525856751;5967.41863406189;5774.82675519735;5779.450952159538;5780.5953583248765;5784.50831679312;5785.537157027512 04:44:16 INFO - PROCESS | 20282 | |5;yui.html;754.4190972950827;766.38689048761;768.1895600141848;776.1268572855538;776.8174478997435;11587.42062896855;11751.764964700722;11781.29312241266;11808.055355571556;11819.70450738732;11629.24409913355;11689;11696.532138714463;11707.297562146256;11710;767.4282659418727;787.0437418536477;788.5741699482272;788.7515432638701;789.1437789997831;788.0936922539069;797.6131576185545;798.1539568057848;798.3972101063689;798.6246464161864;819.0499021135485;822.0915887943826;826.0541679776652;826.1325608111489;826.2976470000511;819.3486178488116;820.9630566624517;822.4530687093076;822.5887056471764;822.5928165558028;605.4218221598363;607.9878402431971;609.6037575575867;609.832296118571;611.5994023914299;11547.480363383667;11599.188056836025;11605.709857253552;11610.303381797035;11652.825207621892;11209.943950280278;11369.2609980351;11695.181337306392;11702.414879256003;12015.098867584878;9331.813363732756;9353.672621458216;9368.39105458143;9504.857427138599;9778.9511052445;3209.9679003210135;3262.2659901522206;3280.5243239730107;3282.261491164493;3353;35969.10077248063;35982.10044748876;36324.455133172756;39802;40375.798121009204;9355;9482.099200575934;9485.193758530602;9534.18959388446;9537.427754334762;15171.317290721943;15183.013104148195;15189.468368607046;15230.923845380923;15294.158821264715;6719.126513553305;6767.830804229934;6918.481113916477;6921.48088893335;6964.721411143599;3772.1135533149686;3821.407681809324;3847.499825022729;3882.456456096149;3888.416737489399;2740.7259274072435;2745.149003808786;2757.531219692657;2759.1446651538085;2776.0977682252947;500.7120905479364;538.2115201230216;541.2179400765856;545.0434487474536;566.4646908671266;434.391851408025;466.82727390865597;485.65761138397346;541.2557733116964;562.8592851787054;6835.248122706498;7066.6819993100435;7296.817579560554;7322.816929576803;7395.223501532261;456.3360310747854;471.0649361018376;551.1980068999596;568.5224411494282;573.5554944917723;3130.765192610563;3200.1679563313705;3244.4971029490466;3387.136280248521;3753.868614598476;44325.55674443214;46317.7684111584;47061.058778824234;47065.29402058972;47547.524524754306;42021.78989105096;42875.142497150504;42953.78523107427;42973.999999999374;43031.56968430338;31279;31754.364912701618;36380;42594.14811703748;42849;7738.806529836574;7755.534667919943;7997.400194985516;8006.399520035904;8008.719694810654;30314.393712126075;30540.236494087825;30938.381232374777;31043.068707938797;31425.900093496617;35999.46000809938;38229.42655860109;38264.61735382722;38323.80838095903;38438.42342364923;9296.907030929604;9398.389104708172;9462.290328225274;10140.239482038729;10587.841182382117;10476.52855621514;10767.192460565333;11503.424828758361;11788.174827761974;12027.639170824888;10502.894971050497;10570;10570.942905709368;10576;10594.841077383999;10389.948050260004;10515.316504427188;10649.254552181274;10659.467026648792;10873.401962892116;10139.39163650154;10231.079202871777;10348.482575871025;10416.37501749867;10536.209784266364;8030.5181689098845;8389.244967952913;8454.450460720034;8478.40651154438;8510.957445212982;8491.575421229038;8568.228859402683;8783.341249406449;8797.340199484936;8832.4959210454 04:44:16 INFO - PROCESS | 20282 | __end_tp_report 04:44:16 INFO - PROCESS | 20282 | __start_cc_report 04:44:16 INFO - PROCESS | 20282 | _x_x_mozilla_cycle_collect,331 04:44:16 INFO - PROCESS | 20282 | __end_cc_report 04:44:16 INFO - PROCESS | 20282 | __startTimestamp1452689056708__endTimestamp 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | ------- Summary: start ------- 04:44:16 INFO - PROCESS | 20282 | Number of tests: 6 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#0] dojo.html Cycles:165 Average:4506.66 Median:4597.77 stddev:456.77 (9.9%) stddev-sans-first:433.75 04:44:16 INFO - PROCESS | 20282 | Values: 2628.1 2652.2 2678.9 2684.5 2705.7 4479.5 4482.1 4516.0 4518.0 4545.8 4452.2 4464.5 4548.1 4570.2 4655.6 4157.7 4187.4 4236.7 4240.5 4277.7 4205.2 4224.0 4229.1 4256.3 4297.5 4154.0 4228.3 4240.3 4277.9 4289.6 4179.1 4197.7 4198.8 4261.5 4278.4 4176.3 4182.1 4201.6 4215.4 4218.6 4283.5 4448.6 4451.9 4456.6 4499.3 4777.7 4860.1 4866.8 4886.0 4945.1 4858.8 4863.7 4879.1 4900.1 4903.8 4406.8 4496.2 4513.8 4542.4 4572.1 4997.4 5021.6 5038.4 5038.9 5066.1 4813.8 4817.1 4834.2 4852.2 4894.1 4758.1 4800.0 4834.0 4925.4 4982.0 4804.0 4829.7 4838.0 4849.0 4880.7 4811.2 4817.3 4824.4 4831.9 4877.2 3986.4 4062.4 4064.9 4072.1 4074.5 3537.1 3559.9 3560.2 3603.5 3604.0 4231.8 4257.7 4284.6 4311.1 4315.2 4794.4 4823.4 4906.8 4937.7 4945.5 4253.5 4263.9 4280.4 4297.6 4338.9 4345.8 4370.6 4371.7 4387.3 4442.2 4469.2 4503.2 4543.6 4579.3 4681.7 4921.0 4932.7 4953.1 4965.9 4981.7 4597.8 4647.6 4650.3 4650.7 4670.5 4698.6 4747.5 4772.7 4802.3 4824.2 4908.3 4909.5 4920.9 4940.9 4984.2 4562.0 4768.9 4777.8 4782.2 4835.0 4658.0 4673.5 4692.4 4705.5 4732.7 4574.7 4579.4 4579.8 4606.9 4653.9 4670.2 4699.8 4718.5 4764.2 4773.6 4694.1 4705.7 4708.1 4730.4 4766.2 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#1] ext.html Cycles:180 Average:40128.42 Median:33908.08 stddev:66541.70 (196.2%) stddev-sans-first:66661.84 04:44:16 INFO - PROCESS | 20282 | Values: 500.7 506.2 515.5 534.3 552.0 32500.8 32910.5 33017.2 33018.2 33260.2 35559.1 36237.0 36335.0 36421.5 36497.8 7696.8 7810.8 7813.7 7820.7 7850.2 7605.3 7714.1 7720.8 7723.3 7786.1 7871.9 7949.7 7955.6 7966.3 7994.4 7856.3 7870.8 7884.8 7893.9 7899.5 7604.8 7663.7 7709.0 7716.7 7766.7 37367.6 37766.0 37795.2 37807.6 37813.6 2963.4 2997.4 3187.0 3270.3 3384.3 28020.7 28390.0 28461.0 28747.7 28969.7 3417.2 3501.7 3502.2 3532.6 3581.2 203695.0 204113.0 204499.0 204618.0 204897.0 37996.0 54057.0 54184.0 54398.5 54640.5 35193.5 35320.0 35435.1 35573.1 35670.5 12559.3 12623.4 12741.2 12772.4 12819.8 10153.3 10185.1 10185.7 10211.3 10236.3 13153.0 13156.5 13184.2 13220.5 13270.7 5381.3 5436.2 5456.2 5495.8 5512.4 788.3 937.7 939.2 998.8 1017.6 25638.0 25831.2 25852.9 26094.6 26273.9 941.2 972.7 999.7 1004.4 1125.5 13947.0 14951.0 15501.5 15575.3 15799.9 304755.0 309369.0 310027.0 311231.0 312019.4 47926.3 48075.5 48171.0 48495.0 48794.8 1178.7 1180.5 1197.7 1235.9 1236.3 27427.0 27835.4 28084.7 28396.9 28520.9 38013.2 38484.2 38544.8 38574.4 38796.4 236749.0 237331.0 238818.0 239341.0 239357.0 29310.3 29377.4 29445.0 29534.0 29572.4 38569.8 38578.8 38784.0 39133.8 39472.8 32596.8 32600.0 33131.7 33335.8 33804.8 33231.7 33511.7 33891.3 33924.8 34162.3 35003.6 35110.3 35225.6 35440.3 35528.3 28440.7 28513.4 30460.7 30570.5 30589.2 23262.6 23270.5 23745.5 23771.4 23823.5 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#2] jquery.html Cycles:180 Average:24374.82 Median:4673.43 stddev:70899.56 (1517.1%) stddev-sans-first:71075.49 04:44:16 INFO - PROCESS | 20282 | Values: 341.0 345.6 346.5 348.1 351.2 13930.9 14196.3 14775.2 15470.0 16429.0 10256.9 10588.6 12791.8 15433.6 15458.1 4426.2 4447.1 4590.9 4693.4 4706.9 4596.7 4660.9 4672.3 4674.6 4693.9 4526.7 4660.4 5732.3 5996.4 5999.8 5930.8 6062.2 6075.7 6340.4 6383.6 6047.6 6073.8 6082.8 6085.5 6102.4 19060.6 19185.6 19623.7 20499.2 20537.1 1879.4 1946.7 1951.8 2007.8 2051.9 13006.7 13038.2 13199.5 13242.4 13256.2 1823.6 1846.2 1850.5 1881.3 1883.6 56169.4 56985.1 57819.4 57912.7 58994.7 14153.4 14518.7 14628.3 14673.6 14729.6 21475.8 21963.0 22009.8 22024.4 22058.0 8393.8 8417.7 8431.0 8467.7 8506.9 7100.8 7102.3 7142.8 7164.3 7174.2 7124.1 7194.5 7229.0 7250.4 7370.9 1747.7 1815.4 2907.3 3098.6 3125.2 778.7 788.8 885.8 915.0 963.0 15079.8 15612.6 15934.4 16059.3 16085.3 852.3 874.6 889.5 909.7 954.8 8687.2 8783.5 8870.6 8901.7 8989.1 420518.0 425568.0 441409.0 441582.0 441683.0 61766.7 62587.7 64030.0 64085.0 64918.4 1079.3 1083.6 1096.2 1109.1 1112.3 13302.3 13375.1 13664.6 13736.0 13968.2 29542.9 30125.8 30334.5 30625.7 31337.4 37336.8 38592.2 38899.8 39442.8 39464.4 6598.3 6713.6 6720.2 6721.6 6928.2 9224.4 9573.3 10150.7 10218.0 10330.8 8368.2 8383.2 8772.8 8779.4 8870.4 9030.4 9030.4 9410.9 9567.4 9621.9 8762.3 8966.5 9267.4 9405.9 9534.2 6597.3 6699.5 6742.2 6782.6 6961.0 7389.6 7929.5 8029.7 8051.2 8164.1 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#3] mootools.html Cycles:180 Average:4738.48 Median:5572.90 stddev:2433.77 (43.7%) stddev-sans-first:2427.40 04:44:16 INFO - PROCESS | 20282 | Values: 1367.0 1373.9 1480.3 1666.4 1676.2 5869.3 5974.0 6793.6 7006.2 7011.4 6484.2 6612.7 6656.1 6702.0 6707.4 2060.4 2064.9 2082.6 2083.8 2086.5 2029.0 2059.9 2062.7 2066.7 2072.4 2041.5 2044.3 2049.9 2055.1 2063.1 2002.8 2012.7 2019.9 2021.9 2022.3 2036.4 2041.2 2065.0 2074.8 2076.3 6914.7 6920.2 6938.4 6939.9 6951.6 3998.0 4127.2 4130.8 4139.8 4155.7 2720.2 2723.7 2730.5 2807.2 2831.6 854.0 867.0 902.3 918.7 927.3 9169.5 9279.3 9321.5 9324.8 9346.5 3689.2 3730.2 3738.9 3746.5 3758.5 7957.5 8005.8 8045.1 8051.3 8063.6 4119.7 4120.2 4120.5 4131.4 4155.8 3195.4 3267.2 3661.8 3734.4 3776.8 3231.6 3269.6 3290.8 3293.2 3305.3 1013.2 1029.1 1029.9 1040.5 1040.6 922.2 926.6 930.4 946.3 976.6 6493.1 6513.2 6562.4 6637.7 6646.8 1024.4 1030.0 1034.8 1035.4 1059.4 5080.1 5110.7 5127.3 5141.3 5175.6 7904.4 7927.5 8042.5 8095.8 8237.9 8362.0 8371.5 8391.9 8416.4 8421.3 6599.8 6615.3 6664.8 6689.1 6723.3 6246.5 6345.7 6397.6 6421.6 6431.1 7155.1 7253.4 7401.6 7428.7 7437.8 7480.3 7678.2 7690.2 7695.7 7697.2 5066.1 5177.8 6011.3 6063.0 6107.5 5932.9 5999.6 6037.6 6046.9 6056.7 5732.6 5754.2 5843.4 5881.9 5957.7 5437.6 5526.5 5542.3 5566.9 5575.4 5703.8 5726.6 5745.9 5755.1 5798.4 5416.8 5427.6 5452.0 5476.1 5479.3 5535.3 5556.4 5565.7 5570.3 5570.4 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#4] prototype.html Cycles:180 Average:4804.62 Median:5525.82 stddev:1442.79 (26.1%) stddev-sans-first:1406.33 04:44:16 INFO - PROCESS | 20282 | Values: 281.6 293.2 297.5 310.8 314.5 5469.5 5511.1 5514.9 5580.6 5627.4 5415.0 5520.2 5531.4 5539.8 5584.7 4102.6 4247.2 4261.7 4264.1 4269.4 4212.1 4226.9 4232.2 4244.8 4256.0 4231.2 4232.9 4233.1 4243.4 4243.6 4212.8 4222.7 4227.3 4234.6 4247.7 3655.8 3670.4 3672.5 3675.9 3678.2 5172.7 5179.5 5325.6 5350.0 5371.8 4753.9 4755.8 4779.3 4781.3 4787.4 5821.1 5853.9 5856.6 5857.3 5862.4 3829.0 3891.7 3899.6 3901.7 3903.9 6070.3 6087.1 6120.6 6121.4 6125.8 4030.2 4037.7 4039.2 4040.3 4044.0 4103.3 4103.8 4108.8 4111.5 4114.6 4782.0 4784.0 4784.8 4785.4 4787.0 5599.4 5662.8 5815.8 5829.9 5844.3 1441.9 1449.2 1451.8 1452.2 1452.4 957.9 960.5 961.2 974.3 979.7 5063.1 5080.5 5088.5 5099.0 5102.0 6036.5 6045.9 6055.8 6056.5 6057.2 5075.0 5085.7 5087.0 5091.9 5094.8 3201.5 3255.5 3265.6 3277.4 3286.4 5608.5 5648.0 5650.7 5652.2 5660.7 6229.6 6244.3 6244.6 6261.5 6266.6 5444.3 5586.4 5625.1 5632.9 5660.1 5993.2 6025.7 6026.9 6038.0 6038.6 5863.6 5894.2 5913.5 5914.6 5929.8 5608.7 5633.6 5636.3 5665.4 5675.1 3994.6 4072.5 4092.8 4102.2 4103.8 5970.3 5979.8 6029.7 6031.0 6119.2 5883.2 5919.1 5920.1 5923.3 5936.0 5909.2 5913.5 5970.5 5980.8 5993.9 5653.8 5787.8 5795.6 5801.3 5819.8 5957.8 5958.0 5958.4 5962.3 5967.4 5774.8 5779.5 5780.6 5784.5 5785.5 04:44:16 INFO - PROCESS | 20282 | 04:44:16 INFO - PROCESS | 20282 | [#5] yui.html Cycles:180 Average:11788.76 Median:43002.78 stddev:13004.63 (30.2%) stddev-sans-first:13014.71 04:44:16 INFO - PROCESS | 20282 | Values: 754.4 766.4 768.2 776.1 776.8 11587.4 11751.8 11781.3 11808.1 11819.7 11629.2 11689.0 11696.5 11707.3 11710.0 767.4 787.0 788.6 788.8 789.1 788.1 797.6 798.2 798.4 798.6 819.0 822.1 826.1 826.1 826.3 819.3 821.0 822.5 822.6 822.6 605.4 608.0 609.6 609.8 611.6 11547.5 11599.2 11605.7 11610.3 11652.8 11209.9 11369.3 11695.2 11702.4 12015.1 9331.8 9353.7 9368.4 9504.9 9779.0 3210.0 3262.3 3280.5 3282.3 3353.0 35969.1 35982.1 36324.5 39802.0 40375.8 9355.0 9482.1 9485.2 9534.2 9537.4 15171.3 15183.0 15189.5 15230.9 15294.2 6719.1 6767.8 6918.5 6921.5 6964.7 3772.1 3821.4 3847.5 3882.5 3888.4 2740.7 2745.1 2757.5 2759.1 2776.1 500.7 538.2 541.2 545.0 566.5 434.4 466.8 485.7 541.3 562.9 6835.2 7066.7 7296.8 7322.8 7395.2 456.3 471.1 551.2 568.5 573.6 3130.8 3200.2 3244.5 3387.1 3753.9 44325.6 46317.8 47061.1 47065.3 47547.5 42021.8 42875.1 42953.8 42974.0 43031.6 31279.0 31754.4 36380.0 42594.1 42849.0 7738.8 7755.5 7997.4 8006.4 8008.7 30314.4 30540.2 30938.4 31043.1 31425.9 35999.5 38229.4 38264.6 38323.8 38438.4 9296.9 9398.4 9462.3 10140.2 10587.8 10476.5 10767.2 11503.4 11788.2 12027.6 10502.9 10570.0 10570.9 10576.0 10594.8 10389.9 10515.3 10649.3 10659.5 10873.4 10139.4 10231.1 10348.5 10416.4 10536.2 8030.5 8389.2 8454.5 8478.4 8511.0 8491.6 8568.2 8783.3 8797.3 8832.5 04:44:16 INFO - PROCESS | 20282 | -------- Summary: end -------- 04:44:16 INFO - PROCESS | 20282 | 04:44:17 INFO - TEST-INFO | 20282: exit 0 04:44:17 INFO - TEST-OK | dromaeo_css | took 1114540ms 04:44:17 INFO - TEST-START | kraken 04:44:17 INFO - operating with platform_type : linux_ 04:44:17 INFO - Initialising browser for kraken test... 04:44:17 INFO - TEST-INFO | started process 20520 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuObwYB/profile http://localhost:52908/getInfo.html) 04:44:21 INFO - PROCESS | 20520 | 04:44:21 INFO - PROCESS | 20520 | (process:20593): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:44:22 INFO - PROCESS | 20520 | __metrics Screen width/height:1600/1200 04:44:22 INFO - PROCESS | 20520 | colorDepth:24 04:44:22 INFO - PROCESS | 20520 | Browser inner width/height: 1024/697 04:44:22 INFO - PROCESS | 20520 | __metrics 04:44:22 INFO - PROCESS | 20520 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:44:23 INFO - TEST-INFO | 20520: exit 0 04:44:23 INFO - Browser initialized. 04:44:23 INFO - Running cycle 1/1 for kraken test... 04:44:23 INFO - TEST-INFO | started process 20642 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuObwYB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:44:24 INFO - PROCESS | 20642 | 04:44:24 INFO - PROCESS | 20642 | (process:20702): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:44:34 INFO - PROCESS | 20642 | RSS: Main: 150814720 04:44:34 INFO - PROCESS | 20642 | 04:44:37 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:38 INFO - PROCESS | 20642 | RSS: Main: 149729280 04:44:38 INFO - PROCESS | 20642 | 04:44:40 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-dft) 04:44:41 INFO - PROCESS | 20642 | RSS: Main: 153800704 04:44:41 INFO - PROCESS | 20642 | 04:44:44 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-fft) 04:44:45 INFO - PROCESS | 20642 | RSS: Main: 148942848 04:44:45 INFO - PROCESS | 20642 | 04:44:47 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52908/tests/kraken/driver.html?testName=audio-oscillator) 04:44:47 INFO - PROCESS | 20642 | RSS: Main: 149389312 04:44:47 INFO - PROCESS | 20642 | 04:44:50 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:50 INFO - PROCESS | 20642 | RSS: Main: 149274624 04:44:50 INFO - PROCESS | 20642 | 04:44:53 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:54 INFO - PROCESS | 20642 | RSS: Main: 148013056 04:44:54 INFO - PROCESS | 20642 | 04:44:57 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52908/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:58 INFO - PROCESS | 20642 | RSS: Main: 146763776 04:44:58 INFO - PROCESS | 20642 | 04:45:01 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52908/tests/kraken/driver.html?testName=json-parse-financial) 04:45:01 INFO - PROCESS | 20642 | RSS: Main: 147406848 04:45:01 INFO - PROCESS | 20642 | 04:45:03 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52908/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:45:04 INFO - PROCESS | 20642 | RSS: Main: 148496384 04:45:04 INFO - PROCESS | 20642 | 04:45:06 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:45:06 INFO - PROCESS | 20642 | RSS: Main: 147390464 04:45:06 INFO - PROCESS | 20642 | 04:45:08 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:09 INFO - PROCESS | 20642 | RSS: Main: 147898368 04:45:09 INFO - PROCESS | 20642 | 04:45:12 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:12 INFO - PROCESS | 20642 | RSS: Main: 148406272 04:45:12 INFO - PROCESS | 20642 | 04:45:15 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:15 INFO - PROCESS | 20642 | RSS: Main: 147734528 04:45:15 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | Cycle 1(1): loaded http://localhost:52908/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52908/tests/kraken/driver.html?testName=ai-astar) 04:45:17 INFO - PROCESS | 20642 | RSS: Main: 148353024 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | __start_tp_report 04:45:17 INFO - PROCESS | 20642 | _x_x_mozilla_page_load 04:45:17 INFO - PROCESS | 20642 | _x_x_mozilla_page_load_details 04:45:17 INFO - PROCESS | 20642 | |i|pagename|runs| 04:45:17 INFO - PROCESS | 20642 | |0;ai-astar;115;110;116;116;115;126;116;117;115;116 04:45:17 INFO - PROCESS | 20642 | |1;audio-beat-detection;168;132;170;164;135;157;156;134;171;132 04:45:17 INFO - PROCESS | 20642 | |2;audio-dft;162;163;166;161;161;164;168;162;163;165 04:45:17 INFO - PROCESS | 20642 | |3;audio-fft;72;73;73;73;128;72;74;75;73;96 04:45:17 INFO - PROCESS | 20642 | |4;audio-oscillator;96;97;136;97;102;99;135;97;97;133 04:45:17 INFO - PROCESS | 20642 | |5;imaging-gaussian-blur;109;110;110;111;110;110;110;110;110;110 04:45:17 INFO - PROCESS | 20642 | |6;imaging-darkroom;148;148;148;148;148;147;148;148;147;147 04:45:17 INFO - PROCESS | 20642 | |7;imaging-desaturate;95;96;97;96;96;97;96;96;96;95 04:45:17 INFO - PROCESS | 20642 | |8;json-parse-financial;69;70;71;70;72;73;71;70;70;69 04:45:17 INFO - PROCESS | 20642 | |9;json-stringify-tinderbox;66;67;67;68;66;68;68;67;67;68 04:45:17 INFO - PROCESS | 20642 | |10;stanford-crypto-aes;82;85;90;83;92;92;83;83;85;84 04:45:17 INFO - PROCESS | 20642 | |11;stanford-crypto-ccm;128;128;127;118;121;132;126;137;138;129 04:45:17 INFO - PROCESS | 20642 | |12;stanford-crypto-pbkdf2;143;151;151;150;153;135;139;151;152;135 04:45:17 INFO - PROCESS | 20642 | |13;stanford-crypto-sha256-iterative;72;72;72;72;77;70;70;72;78;70 04:45:17 INFO - PROCESS | 20642 | __end_tp_report 04:45:17 INFO - PROCESS | 20642 | __start_cc_report 04:45:17 INFO - PROCESS | 20642 | _x_x_mozilla_cycle_collect,805 04:45:17 INFO - PROCESS | 20642 | __end_cc_report 04:45:17 INFO - PROCESS | 20642 | __startTimestamp1452689117853__endTimestamp 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | ------- Summary: start ------- 04:45:17 INFO - PROCESS | 20642 | Number of tests: 14 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#0] ai-astar Cycles:10 Average:116.20 Median:116.00 stddev:3.94 (3.4%) stddev-sans-first:4.15 04:45:17 INFO - PROCESS | 20642 | Values: 115.0 110.0 116.0 116.0 115.0 126.0 116.0 117.0 115.0 116.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:160.50 stddev:16.80 (10.5%) stddev-sans-first:16.77 04:45:17 INFO - PROCESS | 20642 | Values: 168.0 132.0 170.0 164.0 135.0 157.0 156.0 134.0 171.0 132.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.27 (1.4%) stddev-sans-first:2.35 04:45:17 INFO - PROCESS | 20642 | Values: 162.0 163.0 166.0 161.0 161.0 164.0 168.0 162.0 163.0 165.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#3] audio-fft Cycles:10 Average:80.90 Median:73.00 stddev:18.06 (24.7%) stddev-sans-first:18.87 04:45:17 INFO - PROCESS | 20642 | Values: 72.0 73.0 73.0 73.0 128.0 72.0 74.0 75.0 73.0 96.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:97.00 stddev:17.87 (18.4%) stddev-sans-first:18.34 04:45:17 INFO - PROCESS | 20642 | Values: 96.0 97.0 136.0 97.0 102.0 99.0 135.0 97.0 97.0 133.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 04:45:17 INFO - PROCESS | 20642 | Values: 109.0 110.0 110.0 111.0 110.0 110.0 110.0 110.0 110.0 110.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:45:17 INFO - PROCESS | 20642 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 147.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 04:45:17 INFO - PROCESS | 20642 | Values: 95.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 95.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#8] json-parse-financial Cycles:10 Average:70.50 Median:70.50 stddev:1.27 (1.8%) stddev-sans-first:1.22 04:45:17 INFO - PROCESS | 20642 | Values: 69.0 70.0 71.0 70.0 72.0 73.0 71.0 70.0 70.0 69.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 04:45:17 INFO - PROCESS | 20642 | Values: 66.0 67.0 67.0 68.0 66.0 68.0 68.0 67.0 67.0 68.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.90 (4.6%) stddev-sans-first:3.87 04:45:17 INFO - PROCESS | 20642 | Values: 82.0 85.0 90.0 83.0 92.0 92.0 83.0 83.0 85.0 84.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:128.50 stddev:6.24 (4.9%) stddev-sans-first:6.62 04:45:17 INFO - PROCESS | 20642 | Values: 128.0 128.0 127.0 118.0 121.0 132.0 126.0 137.0 138.0 129.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:151.00 stddev:7.27 (4.8%) stddev-sans-first:7.63 04:45:17 INFO - PROCESS | 20642 | Values: 143.0 151.0 151.0 150.0 153.0 135.0 139.0 151.0 152.0 135.0 04:45:17 INFO - PROCESS | 20642 | 04:45:17 INFO - PROCESS | 20642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:2.80 (3.9%) stddev-sans-first:2.96 04:45:17 INFO - PROCESS | 20642 | Values: 72.0 72.0 72.0 72.0 77.0 70.0 70.0 72.0 78.0 70.0 04:45:17 INFO - PROCESS | 20642 | -------- Summary: end -------- 04:45:17 INFO - PROCESS | 20642 | 04:45:18 INFO - TEST-INFO | 20642: exit 0 04:45:18 INFO - TEST-OK | kraken | took 61424ms 04:45:18 INFO - TEST-START | v8_7 04:45:18 INFO - operating with platform_type : linux_ 04:45:18 INFO - Initialising browser for v8_7 test... 04:45:18 INFO - TEST-INFO | started process 20930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Z3e5b/profile http://localhost:52908/getInfo.html) 04:45:22 INFO - PROCESS | 20930 | 04:45:22 INFO - PROCESS | 20930 | (process:21000): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:45:23 INFO - PROCESS | 20930 | __metrics Screen width/height:1600/1200 04:45:23 INFO - PROCESS | 20930 | colorDepth:24 04:45:23 INFO - PROCESS | 20930 | Browser inner width/height: 1024/697 04:45:23 INFO - PROCESS | 20930 | __metrics 04:45:23 INFO - PROCESS | 20930 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:45:24 INFO - TEST-INFO | 20930: exit 0 04:45:24 INFO - Browser initialized. 04:45:24 INFO - Running cycle 1/1 for v8_7 test... 04:45:24 INFO - TEST-INFO | started process 21049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6Z3e5b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:25 INFO - PROCESS | 21049 | 04:45:25 INFO - PROCESS | 21049 | (process:21105): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:45:36 INFO - PROCESS | 21049 | RSS: Main: 150777856 04:45:36 INFO - PROCESS | 21049 | 04:45:58 INFO - PROCESS | 21049 | Cycle 1(1): loaded http://localhost:52908/tests/v8_7/run.html (next: http://localhost:52908/tests/v8_7/run.html) 04:45:59 INFO - PROCESS | 21049 | RSS: Main: 145039360 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | __start_tp_report 04:45:59 INFO - PROCESS | 21049 | _x_x_mozilla_page_load 04:45:59 INFO - PROCESS | 21049 | _x_x_mozilla_page_load_details 04:45:59 INFO - PROCESS | 21049 | |i|pagename|runs| 04:45:59 INFO - PROCESS | 21049 | |0;Richards;169.26201760324983 04:45:59 INFO - PROCESS | 21049 | |1;DeltaBlue;188.96447467876038 04:45:59 INFO - PROCESS | 21049 | |2;Encrypt;278.39643652561244 04:45:59 INFO - PROCESS | 21049 | |3;Decrypt;5164.948453608247 04:45:59 INFO - PROCESS | 21049 | |4;RayTrace;1069.51871657754 04:45:59 INFO - PROCESS | 21049 | |5;Earley;703.7297677691766 04:45:59 INFO - PROCESS | 21049 | |6;Boyer;12395.061728395061 04:45:59 INFO - PROCESS | 21049 | |7;RegExp;42916.666666666664 04:45:59 INFO - PROCESS | 21049 | |8;Splay;615.7635467980296 04:45:59 INFO - PROCESS | 21049 | |9;NavierStokes;4826.923076923077 04:45:59 INFO - PROCESS | 21049 | __end_tp_report 04:45:59 INFO - PROCESS | 21049 | __startTimestamp1452689159154__endTimestamp 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | ------- Summary: start ------- 04:45:59 INFO - PROCESS | 21049 | Number of tests: 10 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#0] Richards Cycles:1 Average:169.26 Median:169.26 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 169.3 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 189.0 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 278.4 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 5164.9 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#4] RayTrace Cycles:1 Average:1069.52 Median:1069.52 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 1069.5 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#5] Earley Cycles:1 Average:703.73 Median:703.73 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 703.7 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 12395.1 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#7] RegExp Cycles:1 Average:42916.67 Median:42916.67 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 42916.7 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 615.8 04:45:59 INFO - PROCESS | 21049 | 04:45:59 INFO - PROCESS | 21049 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 04:45:59 INFO - PROCESS | 21049 | Values: 4826.9 04:45:59 INFO - PROCESS | 21049 | -------- Summary: end -------- 04:45:59 INFO - PROCESS | 21049 | 04:46:00 INFO - TEST-INFO | 21049: exit 0 04:46:00 INFO - TEST-OK | v8_7 | took 41232ms 04:46:00 INFO - SUITE-END | took 1217s 04:46:00 INFO - Completed test suite (00:20:17) 04:46:00 INFO - Working with test: dromaeo_css 04:46:00 INFO - Generating results file: dromaeo_css 04:46:00 INFO - Working with test: kraken 04:46:00 INFO - Generating results file: kraken 04:46:00 INFO - javascript benchmark 04:46:00 INFO - Working with test: v8_7 04:46:00 INFO - Generating results file: v8_7 04:46:00 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:46:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 04:46:00 INFO - process_Request line: dromaeo_css 6203.91 graph.html#tests=[[72,132,43]] 04:46:00 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:46:00 INFO - process_Request line: kraken 1545.60 graph.html#tests=[[232,132,43]] 04:46:00 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:46:00 INFO - process_Request line: v8_7 20246.80 graph.html#tests=[[230,132,43]] 04:46:00 INFO - RETURN: dromaeo_css: 6203.91 04:46:00 INFO - RETURN: kraken: 1545.60 04:46:00 INFO - RETURN: v8_7: 20246.80 04:46:00 INFO - javascript benchmark 04:46:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.106443809107, 2652.1513115802945, 2678.9330266743327, 2684.516786978343, 2705.6617922759656, 4479.529649386808, 4482.103579284144, 4515.977420112903, 4517.977410112949, 4545.795439205235, 4452.1986042512335, 4464.508904020555, 4548.067646132535, 4570.223062079446, 4655.557722016403, 4157.667386609071, 4187.413762073297, 4236.724612900167, 4240.512341080785, 4277.74333539987, 4205.179989901971, 4224.0, 4229.146445338035, 4256.318988961767, 4297.5057868345075, 4153.958460415387, 4228.302330115527, 4240.342746874239, 4277.935830962538, 4289.592488713567, 4179.059711564904, 4197.685173611961, 4198.769067701275, 4261.509926358477, 4278.4010238566625, 4176.2900306947895, 4182.1008483176265, 4201.6008479194425, 4215.430916826251, 4218.557051509578, 4283.507396649394, 4448.621867141297, 4451.931536431265, 4456.64346852251, 4499.3475945987975, 4777.665563410563, 4860.076585448789, 4866.78099485524, 4885.975570122162, 4945.134601444733, 4858.805647774085, 4863.683860549053, 4879.121758083544, 4900.117978763821, 4903.754812259408, 4406.801693923781, 4496.213162696515, 4513.81944722214, 4542.409486766732, 4572.131295053962, 4997.425296090996, 5021.573166280834, 5038.445770965191, 5038.949610503922, 5066.06277838601, 4813.807447702123, 4817.084753896748, 4834.20235661112, 4852.17513022787, 4894.143524883202, 4758.07217592573, 4799.968006878468, 4834.033193361342, 4925.38432695913, 4982.0, 4803.975980120147, 4829.710217386968, 4837.975810120927, 4848.951510484921, 4880.682755620874, 4811.230203167476, 4817.301491283744, 4824.396950381202, 4831.855044348676, 4877.170880950247, 3986.4219688145636, 4062.3906414037538, 4064.898377540585, 4072.063425412172, 4074.5110586729784, 3537.1334023163977, 3559.893203203908, 3560.1989552350515, 3603.4594810778067, 3604.0269127335473, 4231.809568569422, 4257.70196086271, 4284.592963668447, 4311.116221174651, 4315.223259813264, 4794.448638406628, 4823.445303790038, 4906.754662266872, 4937.679050861682, 4945.530174633404, 4253.532111467736, 4263.914721705611, 4280.443542339476, 4297.634701050383, 4338.913221735547, 4345.847895323648, 4370.628496577763, 4371.69398142127, 4387.319965405367, 4442.200403927324, 4469.217886869785, 4503.189425903369, 4543.613792827647, 4579.313103034571, 4681.7425041622355, 4921.040397122527, 4932.728699921395, 4953.083679519301, 4965.851024469127, 4981.726005069756, 4597.770111494478, 4647.55848194421, 4650.302454631832, 4650.697704649187, 4670.462896766915, 4698.624110071254, 4747.454042785124, 4772.665913386029, 4802.303665968485, 4824.155772739687, 4908.312836202863, 4909.459959404534, 4920.901581968269, 4940.876478087933, 4984.2025275955675, 4562.019165879352, 4768.880777980439, 4777.784999675093, 4782.187028205144, 4835.0, 4657.953420465752, 4673.509281525527, 4692.366530518337, 4705.458872229738, 4732.6687131900435, 4574.6569007323915, 4579.35888975537, 4579.793909274024, 4606.930896036629, 4653.930191047205, 4670.1827180244, 4699.788509517011, 4718.528147185254, 4764.237721964469, 4773.618110551217, 4694.084653492536, 4705.7411842349, 4708.058388322418, 4730.408698912636, 4766.237402015661], "unit": "score", "name": "dojo.html", "value": 4479.1809851238995}, {"lowerIsBetter": false, "replicates": [500.69457630845176, 506.2103119134151, 515.4973900447062, 534.2760559441957, 551.9733296069313, 32500.837495812517, 32910.506342404886, 33017.17457063575, 33018.17454563634, 33260.168495787555, 35559.11102222446, 36237.0, 36335.003149653516, 36421.45367819485, 36497.81751091247, 7696.769096927087, 7810.828375743656, 7813.726519571816, 7820.726274580391, 7850.175731548163, 7605.277498637621, 7714.07431108265, 7720.806979825521, 7723.343515801163, 7786.065672119354, 7871.9212807872045, 7949.682012719484, 7955.641996110189, 7966.283034526891, 7994.360451163893, 7856.332211762007, 7870.803229919241, 7884.763457096296, 7893.881591776128, 7899.526028438312, 7604.809879752995, 7663.693452261903, 7709.0, 7716.652750626179, 7766.650500727481, 37367.62632373669, 37766.0, 37795.24409511822, 37807.62192378069, 37813.62186378156, 2963.392504536565, 2997.430488207234, 3186.9840650796828, 3270.3132342208164, 3384.289299247161, 28020.719792802218, 28390.0, 28461.0, 28747.712522874714, 28969.71030289691, 3417.2482053948092, 3501.6673416025437, 3502.2120022994877, 3532.6114127445962, 3581.230035542371, 203695.0, 204113.0, 204498.977505113, 204618.0, 204897.0, 37996.0, 54057.0, 54184.0, 54398.45601543934, 54640.45359546433, 35193.47209791855, 35320.0, 35435.11412214664, 35573.1106722334, 35670.464943025356, 12559.309237991816, 12623.431945562472, 12741.17182383142, 12772.425240864184, 12819.807702884464, 10153.289269751047, 10185.134263587677, 10185.745356366002, 10211.336263142872, 10236.283460157718, 13153.0, 13156.473741050442, 13184.208947463183, 13220.471181152647, 13270.66823329405, 5381.327334083239, 5436.238926550286, 5456.208849716769, 5495.835124946258, 5512.4211957744665, 788.2708494642433, 937.723371605378, 939.1782190583103, 998.8211125315264, 1017.623479312659, 25638.0, 25831.225063248134, 25852.8707356462, 26094.608580871303, 26273.868630656725, 941.2140862379853, 972.6528757670677, 999.6504718629792, 1004.4124187350482, 1125.482278152043, 13947.0, 14951.0, 15501.534953951399, 15575.28671846096, 15799.921000394925, 304755.0, 309369.0, 310027.0, 311231.0, 312019.43990279903, 47926.28110578344, 48075.5192448078, 48171.0, 48495.0, 48794.75602621964, 1178.723000094977, 1180.533689192764, 1197.7484728207, 1235.9196652217577, 1236.2644226685109, 27427.0, 27835.44329113366, 28084.737487170605, 28396.85801570979, 28520.85739571289, 38013.239735205694, 38484.230315392975, 38544.80727596344, 38574.42138367983, 38796.41805372865, 236749.0, 237331.0, 238818.0, 239341.0, 239357.0, 29310.26724331909, 29377.412451751272, 29445.0, 29534.0, 29572.408551828412, 38569.807150964065, 38578.80710596541, 38784.0, 39133.804330978164, 39472.802635986634, 32596.83701581477, 32600.0, 33131.668683312855, 33335.83332083324, 33804.83097584496, 33231.667683322856, 33511.66488335183, 33891.32217355688, 33924.83037584796, 34162.31675366429, 35003.64996350004, 35110.297794043465, 35225.64774352223, 35440.29119417649, 35528.289434211685, 28440.715592843808, 28513.42973140567, 30460.695393045786, 30570.541441878835, 30589.23526911845, 23262.626919096976, 23270.534589308456, 23745.52508949846, 23771.40571485727, 23823.52352952966], "unit": "score", "name": "ext.html", "value": 16267.477746322347}, {"lowerIsBetter": false, "replicates": [340.99318013639726, 345.6232706350079, 346.4716307630863, 348.1036331446524, 351.16598079561044, 13930.930345348272, 14196.290185490723, 14775.187364694964, 15470.0, 16429.0, 10256.948715256412, 10588.629397971072, 12791.784780445843, 15433.614159645986, 15458.07251564907, 4426.203283408985, 4447.0661161156195, 4590.862274131765, 4693.436787585478, 4706.882327941795, 4596.678232523725, 4660.906781864361, 4672.252439609663, 4674.602658773992, 4693.929591056137, 4526.660500462462, 4660.37084993525, 5732.283464566929, 5996.370381109986, 5999.820005399845, 5930.822075337746, 6062.151298818169, 6075.726592303357, 6340.3659634036685, 6383.585066970679, 6047.5766696331275, 6073.757049718006, 6082.756689732405, 6085.452309292141, 6102.359252278536, 19060.61878762417, 19185.616287674307, 19623.705644415346, 20499.18003279867, 20537.075831587616, 1879.370410912346, 1946.698261769428, 1951.7853036166011, 2007.7691065527506, 2051.8768873867616, 13006.739865202737, 13038.152520086163, 13199.472021119143, 13242.404091815892, 13256.20462772227, 1823.5714607067328, 1846.1507706455047, 1850.4633656239675, 1881.2663061405926, 1883.6326916251337, 56169.43830561683, 56985.14522282169, 57819.42180578182, 57912.710436447545, 58994.70502647459, 14153.433862645585, 14518.709625807425, 14628.268586570628, 14673.633159171106, 14729.631759206106, 21475.785242147693, 21963.0, 22009.779902200775, 22024.44938876509, 22058.0, 8393.790155246046, 8417.747467575982, 8431.0, 8467.745967620982, 8506.89410376647, 7100.751473698396, 7102.325279098477, 7142.821429464305, 7164.319389657974, 7174.210836807947, 7124.109486314211, 7194.532355396883, 7229.0, 7250.4199664026755, 7370.852582948418, 1747.7028905086165, 1815.3918437323644, 2907.25864904448, 3098.598586095749, 3125.24994001438, 778.7261197303774, 788.787027502571, 885.8051228729669, 915.0072171693654, 962.9807403851884, 15079.773803392958, 15612.609684757972, 15934.36262549485, 16059.277332520065, 16085.276162572713, 852.318145483623, 874.5539774714941, 889.4574309671225, 909.6907051602487, 954.7565370830393, 8687.218150366498, 8783.516906570072, 8870.556472176366, 8901.685323537391, 8989.146031127033, 420518.0, 425568.0, 441409.0, 441582.0, 441683.0, 61766.69116654478, 62587.68706156531, 64030.0, 64085.0, 64918.35081649217, 1079.2984560036039, 1083.6369816111533, 1096.199774164864, 1109.1071687291808, 1112.2881355932209, 13302.334883255991, 13375.130616509896, 13664.590062298146, 13736.038477306893, 13968.231747253592, 29542.852285738434, 30125.849370753007, 30334.544981825733, 30625.693743062286, 31337.373252534366, 37336.81331593324, 38592.2281554373, 38899.80550097232, 39442.802785985885, 39464.40803388009, 6598.307177746267, 6713.597184168965, 6720.1599800025, 6721.563098398588, 6928.16861976566, 9224.35429519954, 9573.324668183179, 10150.695479135638, 10218.0, 10330.793384132425, 8368.20502052304, 8383.245507904074, 8772.824543508967, 8779.385443018928, 8870.379073465054, 9030.413023153475, 9030.413023153475, 9410.858837117587, 9567.37812042215, 9621.9037809621, 8762.255208307366, 8966.506842123747, 9267.44395336282, 9405.85891211646, 9534.18959388432, 6597.340265973557, 6699.464042876656, 6742.224644165984, 6782.559133656297, 6960.965195173992, 7389.556626602421, 7929.484583502054, 8029.7189598363775, 8051.2351326623875, 8164.061132969785], "unit": "score", "name": "jquery.html", "value": 8194.507998580853}, {"lowerIsBetter": false, "replicates": [1367.043069851104, 1373.8626137386264, 1480.348646595498, 1666.4084250091225, 1676.1619190404797, 5869.266341707286, 5974.0, 6793.59238445693, 7006.159260888688, 7011.439084873211, 6484.1894763154605, 6612.702428390722, 6656.068150458939, 6702.0, 6707.396334329909, 2060.361288000721, 2064.8967551622436, 2082.635538780715, 2083.781202973689, 2086.5305306306113, 2028.9898550507228, 2059.927902523412, 2062.6802845558964, 2066.7209926659934, 2072.4197224777013, 2041.4896275931017, 2044.325372627037, 2049.8975051247453, 2055.085486958304, 2063.1231726516244, 2002.8297594704468, 2012.738344015276, 2019.9091040903122, 2021.9393418197478, 2022.312413779322, 2036.378904434147, 2041.2345370486069, 2065.0397565132134, 2074.771775104737, 2076.3355726167633, 6914.654267286615, 6920.238773734885, 6938.375546200866, 6939.895901561481, 6951.582905025664, 3997.960020399788, 4127.153933443637, 4130.78141948123, 4139.79301034947, 4155.688323375729, 2720.2111387697546, 2723.700392956793, 2730.494858451193, 2807.1718842941177, 2831.6318878545862, 853.9786505337354, 866.9956650216772, 902.3277658144658, 918.678462538113, 927.2581934452478, 9169.495677737721, 9279.304052196045, 9321.487318197496, 9324.766880827965, 9346.485943273185, 3689.2252626948107, 3730.1607138393642, 3738.8504459821847, 3746.512953316106, 3758.511393518825, 7957.5225486471, 8005.8398832024195, 8045.0748163960725, 8051.315638170704, 8063.5968201589685, 4119.670426365884, 4120.237756015147, 4120.546739858613, 4131.35963925592, 4155.750654960712, 3195.408849362875, 3267.232200432896, 3661.7802931824176, 3734.4398340248636, 3776.754510956779, 3231.563738895219, 3269.6239932407602, 3290.753193510496, 3293.2425542125447, 3305.338932213519, 1013.2400699475394, 1029.1252435429974, 1029.9279050466396, 1040.5109598488698, 1040.5681642118436, 922.1516205091198, 926.5876684875166, 930.418488444722, 946.2666433514082, 976.5751897924425, 6493.123428337209, 6513.1532900722605, 6562.409383155444, 6637.668116594247, 6646.833829154213, 1024.3904876598413, 1029.9742506437399, 1034.7568321444455, 1035.4201647077662, 1059.4120263253815, 5080.060188865072, 5110.744462776921, 5127.282180494733, 5141.28022076902, 5175.585953123741, 7904.446688731734, 7927.5243485391065, 8042.477238979564, 8095.83808323842, 8237.917620823835, 8361.95819020901, 8371.455855369382, 8391.874121888177, 8416.410851240355, 8421.284190843848, 6599.8020059398295, 6615.338466153443, 6664.83337916556, 6689.096971908827, 6723.294054124344, 6246.46905013079, 6345.746170153142, 6397.616143031433, 6421.550491465552, 6431.1317972073175, 7155.069840920647, 7253.419726421768, 7401.59291238987, 7428.702851885864, 7437.8140546486775, 7480.326770590673, 7678.1937896522295, 7690.154083050748, 7695.6921723130445, 7697.191794861459, 5066.08810414129, 5177.8187763428095, 6011.27864656244, 6062.969685151546, 6107.450329470369, 5932.8813423732145, 5999.5800293979, 6037.63774173551, 6046.90929636047, 6056.6971651418135, 5732.57005724564, 5754.165645981393, 5843.444872737083, 5881.911771323348, 5957.702114894151, 5437.592180586393, 5526.50261476469, 5542.334919809648, 5566.860828479321, 5575.414581468887, 5703.800366987136, 5726.570507211893, 5745.885082298414, 5755.050416681201, 5798.391168927371, 5416.75624596902, 5427.592930530305, 5452.045891968969, 5476.069068258326, 5479.287692599936, 5535.252740880091, 5556.361018482765, 5565.749541270734, 5570.331560212639, 5570.387257401763], "unit": "score", "name": "mootools.html", "value": 3922.3485192461126}, {"lowerIsBetter": false, "replicates": [281.56498210265147, 293.17763672897524, 297.5135653207007, 310.8166181952649, 314.49523514758795, 5469.535089517396, 5511.145772405283, 5514.889702205954, 5580.581456390772, 5627.352854421742, 5414.972925135378, 5520.227168196456, 5531.419200983889, 5539.778408863641, 5584.720763961806, 4102.630763231324, 4247.193033323674, 4261.701680882339, 4264.147170565884, 4269.423627810237, 4212.115455754295, 4226.894327641803, 4232.195882782277, 4244.830206791725, 4256.0, 4231.153769246148, 4232.851850185244, 4233.111046680201, 4243.366303972977, 4243.618074373306, 4212.768297743638, 4222.662187025031, 4227.309076369446, 4234.597713217239, 4247.660187185018, 3655.780653160792, 3670.376036073874, 3672.5225720656413, 3675.8529658813613, 3678.2275722098393, 5172.689638621657, 5179.456157103526, 5325.573954083664, 5349.973250133763, 5371.811986580451, 4753.857384278477, 4755.833545825914, 4779.330893674888, 4781.330613714083, 4787.4494433139935, 5821.09772985188, 5853.941460585383, 5856.590038697293, 5857.26784151981, 5862.443067908542, 3829.0427393151713, 3891.6692081173132, 3899.5571638493657, 3901.6683581895572, 3903.941440878389, 6070.301915279755, 6087.147799308056, 6120.632762034292, 6121.387861213888, 6125.785597504066, 4030.1939612077704, 4037.6567991720444, 4039.1921615676983, 4040.3333449980423, 4044.0, 4103.261412945699, 4103.794810259535, 4108.77401742901, 4111.48606424197, 4114.6091121343425, 4782.0435912817575, 4783.976080119577, 4784.808607655725, 4785.353977213032, 4786.976065119652, 5599.356074051455, 5662.830115096472, 5815.82552523425, 5829.88340233193, 5844.298684157843, 1441.891858110646, 1449.1884544655027, 1451.7604595241878, 1452.2158034661377, 1452.3682198243798, 957.9329446938787, 960.4717405426987, 961.1733908838394, 974.3423189347162, 979.7403688022537, 5063.11395505785, 5080.466551012164, 5088.542031217208, 5099.031184075014, 5102.0, 6036.5170786336985, 6045.879082418415, 6055.818325450244, 6056.485198758067, 6057.151998720183, 5074.974625126851, 5085.6948583084395, 5087.0, 5091.9236211456855, 5094.847154585368, 3201.4557525220766, 3255.544223808669, 3265.591801024872, 3277.393682168806, 3286.4248756467523, 5608.495235428831, 5648.0, 5650.74571644277, 5652.208690783212, 5660.716964151776, 6229.626222426669, 6244.344343843922, 6244.625322480666, 6261.467775239155, 6266.561340706198, 5444.3194600674915, 5586.413426590149, 5625.099984002622, 5632.85917852057, 5660.122680984454, 5993.190919225849, 6025.66858822769, 6026.90959635597, 6038.033914573647, 6038.63768173911, 5863.618864773776, 5894.233749612523, 5913.497352725067, 5914.58597898143, 5929.762809487572, 5608.747606357805, 5633.63381380209, 5636.267285252891, 5665.433456654301, 5675.0919852825, 3994.6205110514456, 4072.511298644182, 4092.795360231917, 4102.2000709861295, 4103.835846566104, 5970.253718285215, 5979.820605381846, 6029.698515074317, 6031.0, 6119.204503414706, 5883.2057672215415, 5919.082542205965, 5920.111983202554, 5923.259592550931, 5935.970320148372, 5909.172715819703, 5913.526917846476, 5970.462658360769, 5980.790672326448, 5993.850153746017, 5653.802116925888, 5787.826365209051, 5795.623284486495, 5801.3038435388025, 5819.76720931158, 5957.76168953237, 5957.970210149095, 5958.433948775033, 5962.284525856751, 5967.41863406189, 5774.82675519735, 5779.450952159538, 5780.5953583248765, 5784.50831679312, 5785.537157027512], "unit": "score", "name": "prototype.html", "value": 4332.915051997345}, {"lowerIsBetter": false, "replicates": [754.4190972950827, 766.38689048761, 768.1895600141848, 776.1268572855538, 776.8174478997435, 11587.42062896855, 11751.764964700722, 11781.29312241266, 11808.055355571556, 11819.70450738732, 11629.24409913355, 11689.0, 11696.532138714463, 11707.297562146256, 11710.0, 767.4282659418727, 787.0437418536477, 788.5741699482272, 788.7515432638701, 789.1437789997831, 788.0936922539069, 797.6131576185545, 798.1539568057848, 798.3972101063689, 798.6246464161864, 819.0499021135485, 822.0915887943826, 826.0541679776652, 826.1325608111489, 826.2976470000511, 819.3486178488116, 820.9630566624517, 822.4530687093076, 822.5887056471764, 822.5928165558028, 605.4218221598363, 607.9878402431971, 609.6037575575867, 609.832296118571, 611.5994023914299, 11547.480363383667, 11599.188056836025, 11605.709857253552, 11610.303381797035, 11652.825207621892, 11209.943950280278, 11369.2609980351, 11695.181337306392, 11702.414879256003, 12015.098867584878, 9331.813363732756, 9353.672621458216, 9368.39105458143, 9504.857427138599, 9778.9511052445, 3209.9679003210135, 3262.2659901522206, 3280.5243239730107, 3282.261491164493, 3353.0, 35969.10077248063, 35982.10044748876, 36324.455133172756, 39802.0, 40375.798121009204, 9355.0, 9482.099200575934, 9485.193758530602, 9534.18959388446, 9537.427754334762, 15171.317290721943, 15183.013104148195, 15189.468368607046, 15230.923845380923, 15294.158821264715, 6719.126513553305, 6767.830804229934, 6918.481113916477, 6921.48088893335, 6964.721411143599, 3772.1135533149686, 3821.407681809324, 3847.499825022729, 3882.456456096149, 3888.416737489399, 2740.7259274072435, 2745.149003808786, 2757.531219692657, 2759.1446651538085, 2776.0977682252947, 500.7120905479364, 538.2115201230216, 541.2179400765856, 545.0434487474536, 566.4646908671266, 434.391851408025, 466.82727390865597, 485.65761138397346, 541.2557733116964, 562.8592851787054, 6835.248122706498, 7066.6819993100435, 7296.817579560554, 7322.816929576803, 7395.223501532261, 456.3360310747854, 471.0649361018376, 551.1980068999596, 568.5224411494282, 573.5554944917723, 3130.765192610563, 3200.1679563313705, 3244.4971029490466, 3387.136280248521, 3753.868614598476, 44325.55674443214, 46317.7684111584, 47061.058778824234, 47065.29402058972, 47547.524524754306, 42021.78989105096, 42875.142497150504, 42953.78523107427, 42973.999999999374, 43031.56968430338, 31279.0, 31754.364912701618, 36380.0, 42594.14811703748, 42849.0, 7738.806529836574, 7755.534667919943, 7997.400194985516, 8006.399520035904, 8008.719694810654, 30314.393712126075, 30540.236494087825, 30938.381232374777, 31043.068707938797, 31425.900093496617, 35999.46000809938, 38229.42655860109, 38264.61735382722, 38323.80838095903, 38438.42342364923, 9296.907030929604, 9398.389104708172, 9462.290328225274, 10140.239482038729, 10587.841182382117, 10476.52855621514, 10767.192460565333, 11503.424828758361, 11788.174827761974, 12027.639170824888, 10502.894971050497, 10570.0, 10570.942905709368, 10576.0, 10594.841077383999, 10389.948050260004, 10515.316504427188, 10649.254552181274, 10659.467026648792, 10873.401962892116, 10139.39163650154, 10231.079202871777, 10348.482575871025, 10416.37501749867, 10536.209784266364, 8030.5181689098845, 8389.244967952913, 8454.450460720034, 8478.40651154438, 8510.957445212982, 8491.575421229038, 8568.228859402683, 8783.341249406449, 8797.340199484936, 8832.4959210454], "unit": "score", "name": "yui.html", "value": 5617.9928591143225}], "name": "dromaeo_css", "value": 6203.912854707695}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 110.0, 116.0, 116.0, 115.0, 126.0, 116.0, 117.0, 115.0, 116.0], "unit": "score", "name": "ai-astar", "value": 116.2}, {"lowerIsBetter": true, "replicates": [168.0, 132.0, 170.0, 164.0, 135.0, 157.0, 156.0, 134.0, 171.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 166.0, 161.0, 161.0, 164.0, 168.0, 162.0, 163.0, 165.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 73.0, 128.0, 72.0, 74.0, 75.0, 73.0, 96.0], "unit": "score", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 136.0, 97.0, 102.0, 99.0, 135.0, 97.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 70.0, 72.0, 73.0, 71.0, 70.0, 70.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.5}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 68.0, 66.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 90.0, 83.0, 92.0, 92.0, 83.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 127.0, 118.0, 121.0, 132.0, 126.0, 137.0, 138.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [143.0, 151.0, 151.0, 150.0, 153.0, 135.0, 139.0, 151.0, 152.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 72.0, 77.0, 70.0, 70.0, 72.0, 78.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.5}], "name": "kraken", "value": 1545.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.26201760324983], "unit": "score", "name": "Richards", "value": 208.56421600000007}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [1069.51871657754], "unit": "score", "name": "RayTrace", "value": 691.889715}, {"lowerIsBetter": false, "replicates": [703.7297677691766], "unit": "score", "name": "Earley", "value": 947.0439230000003}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [42916.666666666664], "unit": "score", "name": "RegExp", "value": 21.22683495145631}, {"lowerIsBetter": false, "replicates": [615.7635467980296], "unit": "score", "name": "Splay", "value": 132.34138400000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20246.795048527703}]} 04:46:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20246.80"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1545.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6203.91"}}} 04:46:00 INFO - Return code: 0 04:46:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:46:00 INFO - # TBPL SUCCESS # 04:46:00 INFO - Running post-action listener: _resource_record_post_action 04:46:00 INFO - Running post-run listener: _resource_record_post_run 04:46:01 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 378494976; Read time: 8; Write time: 227836 04:46:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 32845824; Read time: 0; Write time: 24772 04:46:01 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310181888; Read time: 8; Write time: 191860 04:46:01 INFO - Running post-run listener: _upload_blobber_files 04:46:01 INFO - Blob upload gear active. 04:46:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:46:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:46:01 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'] 04:46:01 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 04:46:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:46:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:46:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:46:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:03 INFO - (blobuploader) - INFO - Done attempting. 04:46:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:46:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:46:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:46:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:46:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:46:04 INFO - (blobuploader) - INFO - Done attempting. 04:46:04 INFO - (blobuploader) - INFO - Iteration through files over. 04:46:04 INFO - Return code: 0 04:46:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:46:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:46:04 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c6c52a1298bce4f89558b3207ec79609a290238d8e3e036c133f2ae568ee1949b8fbf49f8db639aa7f33f6f0116de63f6b95efaa64241fbf863cbcf84cfe9b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b345a4e4961b92aa445347a17ae0717e4a946c4e18cd487f0fec8bd5a6ca5981fc0d9e02d7658c8fd66bb47e3e83bfe5ea227c38f6bd1c7bf4930d0edbf007"} 04:46:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:46:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:46:04 INFO - Contents: 04:46:04 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c6c52a1298bce4f89558b3207ec79609a290238d8e3e036c133f2ae568ee1949b8fbf49f8db639aa7f33f6f0116de63f6b95efaa64241fbf863cbcf84cfe9b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b345a4e4961b92aa445347a17ae0717e4a946c4e18cd487f0fec8bd5a6ca5981fc0d9e02d7658c8fd66bb47e3e83bfe5ea227c38f6bd1c7bf4930d0edbf007"} 04:46:04 INFO - Copying logs to upload dir... 04:46:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1292.823866 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-01-13 04:46:04.054872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:46:04.057958) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c6c52a1298bce4f89558b3207ec79609a290238d8e3e036c133f2ae568ee1949b8fbf49f8db639aa7f33f6f0116de63f6b95efaa64241fbf863cbcf84cfe9b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b345a4e4961b92aa445347a17ae0717e4a946c4e18cd487f0fec8bd5a6ca5981fc0d9e02d7658c8fd66bb47e3e83bfe5ea227c38f6bd1c7bf4930d0edbf007"} build_url:https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011273 build_url: 'https://queue.taskcluster.net/v1/task/R7B95WoPSWSa1w0EpH2WcQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3c6c52a1298bce4f89558b3207ec79609a290238d8e3e036c133f2ae568ee1949b8fbf49f8db639aa7f33f6f0116de63f6b95efaa64241fbf863cbcf84cfe9b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34b345a4e4961b92aa445347a17ae0717e4a946c4e18cd487f0fec8bd5a6ca5981fc0d9e02d7658c8fd66bb47e3e83bfe5ea227c38f6bd1c7bf4930d0edbf007"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:46:04.082849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:46:04.083369) ========= 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=32c5991c409366f7fec8a718000001d2-1452687407.37973-951477387 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:46:04.166548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:46:04.166880) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:46:04.167168) ========= ========= Total master_lag: 0.22 =========