builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1467889951.01 results: success (0) buildid: 20160706215822 builduid: 005acac198204b229cc2500b323a4168 revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.012012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.012557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.012882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.026273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.026741) ========= 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-1467889950.309040-246410382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 04:12:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-07-07 04:12:31 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.143838) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.144205) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013786 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.194652) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.195056) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d142c49033c015f67272562b37dbe2912cfc7f14 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d142c49033c015f67272562b37dbe2912cfc7f14 --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-1467889950.309040-246410382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 04:12:31,421 truncating revision to first 12 chars 2016-07-07 04:12:31,421 Setting DEBUG logging. 2016-07-07 04:12:31,421 attempt 1/10 2016-07-07 04:12:31,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d142c49033c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 04:12:31,784 unpacking tar archive at: mozilla-beta-d142c49033c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.786687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.996431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.996813) ========= script_repo_revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.997314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:31.997633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 04:12:32.007809) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-07 04:12:32.008275) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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-1467889950.309040-246410382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:12:32 INFO - MultiFileLogger online at 20160707 04:12:32 in /builds/slave/test 04:12:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:12:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:12:32 INFO - {'append_to_log': False, 04:12:32 INFO - 'base_work_dir': '/builds/slave/test', 04:12:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:12:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:12:32 INFO - 'branch': 'Mozilla-Beta', 04:12:32 INFO - 'buildbot_json_path': 'buildprops.json', 04:12:32 INFO - 'config_files': ('talos/linux_config.py',), 04:12:32 INFO - 'default_actions': ('clobber', 04:12:32 INFO - 'read-buildbot-config', 04:12:32 INFO - 'download-and-extract', 04:12:32 INFO - 'populate-webroot', 04:12:32 INFO - 'create-virtualenv', 04:12:32 INFO - 'install', 04:12:32 INFO - 'run-tests'), 04:12:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:12:32 INFO - 'download_minidump_stackwalk': True, 04:12:32 INFO - 'download_symbols': 'ondemand', 04:12:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:12:32 INFO - 'tooltool.py': '/tools/tooltool.py', 04:12:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:12:32 INFO - '/tools/misc-python/virtualenv.py')}, 04:12:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:12:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:12:32 INFO - 'installer_path': 'installer.exe', 04:12:32 INFO - 'log_level': 'info', 04:12:32 INFO - 'log_name': 'talos', 04:12:32 INFO - 'log_to_console': True, 04:12:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:12:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:12:32 INFO - 'opt_config_files': (), 04:12:32 INFO - 'pip_index': False, 04:12:32 INFO - 'sps_profile': False, 04:12:32 INFO - 'sps_profile_interval': 0, 04:12:32 INFO - 'suite': 'dromaeojs-e10s', 04:12:32 INFO - 'system_bits': '32', 04:12:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:12:32 INFO - 'title': 'talos-linux64-ix-008', 04:12:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:12:32 INFO - 'use_talos_json': True, 04:12:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:12:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:12:32 INFO - 'work_dir': 'build'} 04:12:32 INFO - ##### 04:12:32 INFO - ##### Running clobber step. 04:12:32 INFO - ##### 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: clobber 04:12:32 INFO - rmtree: /builds/slave/test/build 04:12:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - ##### 04:12:32 INFO - ##### Running read-buildbot-config step. 04:12:32 INFO - ##### 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: read_buildbot_config 04:12:32 INFO - Using buildbot properties: 04:12:32 INFO - { 04:12:32 INFO - "project": "", 04:12:32 INFO - "product": "firefox", 04:12:32 INFO - "script_repo_revision": "production", 04:12:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 04:12:32 INFO - "repository": "", 04:12:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 04:12:32 INFO - "buildid": "20160706215822", 04:12:32 INFO - "pgo_build": "True", 04:12:32 INFO - "basedir": "/builds/slave/test", 04:12:32 INFO - "buildnumber": 36, 04:12:32 INFO - "slavename": "talos-linux64-ix-008", 04:12:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:12:32 INFO - "platform": "ubuntu64_hw", 04:12:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 04:12:32 INFO - "branch": "mozilla-beta", 04:12:32 INFO - "repo_path": "releases/mozilla-beta", 04:12:32 INFO - "revision": "d142c49033c015f67272562b37dbe2912cfc7f14", 04:12:32 INFO - "stage_platform": "linux64-pgo", 04:12:32 INFO - "builduid": "005acac198204b229cc2500b323a4168", 04:12:32 INFO - "slavebuilddir": "test" 04:12:32 INFO - } 04:12:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 04:12:32 INFO - Running post-action listener: _resource_record_post_action 04:12:32 INFO - ##### 04:12:32 INFO - ##### Running download-and-extract step. 04:12:32 INFO - ##### 04:12:32 INFO - Running pre-action listener: _resource_record_pre_action 04:12:32 INFO - Running main action method: download_and_extract 04:12:32 INFO - mkdir: /builds/slave/test/build/tests 04:12:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:32 INFO - https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:12:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:12:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:12:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:12:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:12:33 INFO - Downloaded 1327 bytes. 04:12:33 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 04:12:33 INFO - Using the following test package requirements: 04:12:33 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:12:33 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 04:12:33 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 04:12:33 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'jsshell-linux-x86_64.zip'], 04:12:33 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 04:12:33 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 04:12:33 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 04:12:33 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 04:12:33 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 04:12:33 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 04:12:33 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 04:12:33 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:12:33 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:12:33 INFO - https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:34 INFO - Downloaded 24237367 bytes. 04:12:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:35 INFO - Return code: 0 04:12:35 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:12:35 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:12:35 INFO - https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:12:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 04:12:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:12:36 INFO - Downloaded 24237367 bytes. 04:12:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:12:38 INFO - Return code: 0 04:12:38 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:12:38 INFO - https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 04:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:12:39 INFO - Downloaded 10840145 bytes. 04:12:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:12:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:12:39 INFO - Return code: 0 04:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:39 INFO - https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:12:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:12:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:12:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:12:42 INFO - Downloaded 56031681 bytes. 04:12:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:12:42 INFO - mkdir: /builds/slave/test/properties 04:12:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:12:42 INFO - Writing to file /builds/slave/test/properties/build_url 04:12:42 INFO - Contents: 04:12:42 INFO - build_url:https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 04:12:43 INFO - Running post-action listener: _resource_record_post_action 04:12:43 INFO - Running post-action listener: set_extra_try_arguments 04:12:43 INFO - ##### 04:12:43 INFO - ##### Running populate-webroot step. 04:12:43 INFO - ##### 04:12:43 INFO - Running pre-action listener: _resource_record_pre_action 04:12:43 INFO - Running main action method: populate_webroot 04:12:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:12:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:12:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:12:43 INFO - '--tppagecycles', 04:12:43 INFO - '7'], 04:12:43 INFO - 'tests': ['tsvgm']}}, 04:12:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:12:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:12:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:12:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:12:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:12:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['damp', 'tps']}, 04:12:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'tests': ['damp', 'tps']}, 04:12:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['dromaeo_dom']}, 04:12:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:12:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['a11yr', 04:12:43 INFO - 'ts_paint', 04:12:43 INFO - 'tpaint', 04:12:43 INFO - 'sessionrestore', 04:12:43 INFO - 'sessionrestore_no_auto_restore', 04:12:43 INFO - 'tabpaint']}, 04:12:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['tsvgx', 04:12:43 INFO - 'tsvgr_opacity', 04:12:43 INFO - 'tart', 04:12:43 INFO - 'tscrollx', 04:12:43 INFO - 'cart']}, 04:12:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:12:43 INFO - 'tsvgr_opacity', 04:12:43 INFO - 'tart', 04:12:43 INFO - 'tscrollx', 04:12:43 INFO - 'cart']}, 04:12:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'talos_options': ['--disable-e10s'], 04:12:43 INFO - 'tests': ['tp5o']}, 04:12:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'tests': ['tp5o']}, 04:12:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'talos_options': ['--disable-e10s', 04:12:43 INFO - '--xperf_path', 04:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:43 INFO - 'tests': ['tp5n']}, 04:12:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:12:43 INFO - 'talos_options': ['--xperf_path', 04:12:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:12:43 INFO - 'tests': ['tp5n']}}, 04:12:43 INFO - 'talos.zip': {'path': '', 04:12:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:12:43 INFO - Running post-action listener: _resource_record_post_action 04:12:43 INFO - ##### 04:12:43 INFO - ##### Running create-virtualenv step. 04:12:43 INFO - ##### 04:12:43 INFO - Running pre-action listener: _resource_record_pre_action 04:12:43 INFO - Running main action method: create_virtualenv 04:12:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:12:43 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:12:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:12:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:12:43 INFO - Using real prefix '/usr' 04:12:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:12:43 INFO - Installing distribute.............................................................................................................................................................................................done. 04:12:45 INFO - Installing pip.................done. 04:12:45 INFO - Return code: 0 04:12:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:12:45 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:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 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:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:12:45 INFO - Using env: {'DISPLAY': ':0', 04:12:45 INFO - 'HOME': '/home/cltbld', 04:12:45 INFO - 'LANG': 'en_US.UTF-8', 04:12:45 INFO - 'LANGUAGE': 'en_US:en', 04:12:45 INFO - 'LOGNAME': 'cltbld', 04:12:45 INFO - 'MAIL': '/var/mail/cltbld', 04:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:45 INFO - 'MOZ_NO_REMOTE': '1', 04:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:45 INFO - 'NO_EM_RESTART': '1', 04:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:45 INFO - 'PWD': '/builds/slave/test', 04:12:45 INFO - 'SHELL': '/bin/bash', 04:12:45 INFO - 'SHLVL': '1', 04:12:45 INFO - 'TERM': 'linux', 04:12:45 INFO - 'TMOUT': '86400', 04:12:45 INFO - 'USER': 'cltbld', 04:12:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:45 INFO - '_': '/tools/buildbot/bin/python'} 04:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:46 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:12:46 INFO - Cleaning up... 04:12:46 INFO - Return code: 0 04:12:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:12:46 INFO - Using env: {'DISPLAY': ':0', 04:12:46 INFO - 'HOME': '/home/cltbld', 04:12:46 INFO - 'LANG': 'en_US.UTF-8', 04:12:46 INFO - 'LANGUAGE': 'en_US:en', 04:12:46 INFO - 'LOGNAME': 'cltbld', 04:12:46 INFO - 'MAIL': '/var/mail/cltbld', 04:12:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:46 INFO - 'MOZ_NO_REMOTE': '1', 04:12:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:46 INFO - 'NO_EM_RESTART': '1', 04:12:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:46 INFO - 'PWD': '/builds/slave/test', 04:12:46 INFO - 'SHELL': '/bin/bash', 04:12:46 INFO - 'SHLVL': '1', 04:12:46 INFO - 'TERM': 'linux', 04:12:46 INFO - 'TMOUT': '86400', 04:12:46 INFO - 'USER': 'cltbld', 04:12:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:46 INFO - '_': '/tools/buildbot/bin/python'} 04:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:46 INFO - Downloading/unpacking psutil>=0.7.1 04:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:46 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:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:12:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:48 INFO - Installing collected packages: psutil 04:12:48 INFO - Running setup.py install for psutil 04:12:48 INFO - building 'psutil._psutil_linux' extension 04:12:48 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:12:48 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:12:48 INFO - building 'psutil._psutil_posix' extension 04:12:48 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:12:48 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:12:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:12:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:12:48 INFO - Successfully installed psutil 04:12:48 INFO - Cleaning up... 04:12:48 INFO - Return code: 0 04:12:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:12: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:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12: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:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:12:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:12:48 INFO - Using env: {'DISPLAY': ':0', 04:12:48 INFO - 'HOME': '/home/cltbld', 04:12:48 INFO - 'LANG': 'en_US.UTF-8', 04:12:48 INFO - 'LANGUAGE': 'en_US:en', 04:12:48 INFO - 'LOGNAME': 'cltbld', 04:12:48 INFO - 'MAIL': '/var/mail/cltbld', 04:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:48 INFO - 'MOZ_NO_REMOTE': '1', 04:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:48 INFO - 'NO_EM_RESTART': '1', 04:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:48 INFO - 'PWD': '/builds/slave/test', 04:12:48 INFO - 'SHELL': '/bin/bash', 04:12:48 INFO - 'SHLVL': '1', 04:12:48 INFO - 'TERM': 'linux', 04:12:48 INFO - 'TMOUT': '86400', 04:12:48 INFO - 'USER': 'cltbld', 04:12:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:48 INFO - '_': '/tools/buildbot/bin/python'} 04:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:12:49 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:12:49 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:12:49 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:12:49 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:12:49 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:12:49 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:12:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:12:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:12:51 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:12:51 INFO - Installing collected packages: mozsystemmonitor 04:12:51 INFO - Running setup.py install for mozsystemmonitor 04:12:51 INFO - Successfully installed mozsystemmonitor 04:12:51 INFO - Cleaning up... 04:12:51 INFO - Return code: 0 04:12:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:12:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:12:51 INFO - Using env: {'DISPLAY': ':0', 04:12:51 INFO - 'HOME': '/home/cltbld', 04:12:51 INFO - 'LANG': 'en_US.UTF-8', 04:12:51 INFO - 'LANGUAGE': 'en_US:en', 04:12:51 INFO - 'LOGNAME': 'cltbld', 04:12:51 INFO - 'MAIL': '/var/mail/cltbld', 04:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:51 INFO - 'MOZ_NO_REMOTE': '1', 04:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:51 INFO - 'NO_EM_RESTART': '1', 04:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:51 INFO - 'PWD': '/builds/slave/test', 04:12:51 INFO - 'SHELL': '/bin/bash', 04:12:51 INFO - 'SHLVL': '1', 04:12:51 INFO - 'TERM': 'linux', 04:12:51 INFO - 'TMOUT': '86400', 04:12:51 INFO - 'USER': 'cltbld', 04:12:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:51 INFO - '_': '/tools/buildbot/bin/python'} 04:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:51 INFO - Downloading/unpacking blobuploader==1.2.4 04:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:51 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:12:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:12:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:12:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 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:12:53 INFO - Downloading docopt-0.6.1.tar.gz 04:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:12:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:12:54 INFO - Running setup.py install for blobuploader 04:12:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:12:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:12:54 INFO - Running setup.py install for requests 04:12:54 INFO - Running setup.py install for docopt 04:12:54 INFO - Successfully installed blobuploader requests docopt 04:12:54 INFO - Cleaning up... 04:12:54 INFO - Return code: 0 04:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:54 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:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:54 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:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:54 INFO - Using env: {'DISPLAY': ':0', 04:12:54 INFO - 'HOME': '/home/cltbld', 04:12:54 INFO - 'LANG': 'en_US.UTF-8', 04:12:54 INFO - 'LANGUAGE': 'en_US:en', 04:12:54 INFO - 'LOGNAME': 'cltbld', 04:12:54 INFO - 'MAIL': '/var/mail/cltbld', 04:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:54 INFO - 'MOZ_NO_REMOTE': '1', 04:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:54 INFO - 'NO_EM_RESTART': '1', 04:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:54 INFO - 'PWD': '/builds/slave/test', 04:12:54 INFO - 'SHELL': '/bin/bash', 04:12:54 INFO - 'SHLVL': '1', 04:12:54 INFO - 'TERM': 'linux', 04:12:54 INFO - 'TMOUT': '86400', 04:12:54 INFO - 'USER': 'cltbld', 04:12:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:54 INFO - '_': '/tools/buildbot/bin/python'} 04:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:54 INFO - Running setup.py (path:/tmp/pip-eaJTlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:54 INFO - Running setup.py (path:/tmp/pip-IfIqUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:54 INFO - Running setup.py (path:/tmp/pip-etCee7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:55 INFO - Running setup.py (path:/tmp/pip-O2flOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:55 INFO - Running setup.py (path:/tmp/pip-WMzVkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:55 INFO - Running setup.py (path:/tmp/pip-_ObMgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:55 INFO - Running setup.py (path:/tmp/pip-x6zAIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:55 INFO - Running setup.py (path:/tmp/pip-8ixJdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:55 INFO - Running setup.py (path:/tmp/pip-Nh5RLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:55 INFO - Running setup.py (path:/tmp/pip-4QEfIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:55 INFO - Running setup.py (path:/tmp/pip-TeLNnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:55 INFO - Running setup.py (path:/tmp/pip-n3ohJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:55 INFO - Running setup.py (path:/tmp/pip-T0Yoxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:55 INFO - Running setup.py (path:/tmp/pip-PRNbMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:55 INFO - Running setup.py (path:/tmp/pip-jr2X1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:55 INFO - Running setup.py (path:/tmp/pip-MvSxzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:55 INFO - Running setup.py (path:/tmp/pip-rvemrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:12:56 INFO - Running setup.py install for manifestparser 04:12:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Running setup.py install for mozcrash 04:12:56 INFO - Running setup.py install for mozdebug 04:12:56 INFO - Running setup.py install for mozdevice 04:12:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Running setup.py install for mozfile 04:12:56 INFO - Running setup.py install for mozhttpd 04:12:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Running setup.py install for mozinfo 04:12:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Running setup.py install for mozInstall 04:12:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:12:56 INFO - Running setup.py install for mozleak 04:12:56 INFO - Running setup.py install for mozlog 04:12:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Running setup.py install for moznetwork 04:12:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Running setup.py install for mozprocess 04:12:57 INFO - Running setup.py install for mozprofile 04:12:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Running setup.py install for mozrunner 04:12:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Running setup.py install for mozscreenshot 04:12:57 INFO - Running setup.py install for moztest 04:12:57 INFO - Running setup.py install for mozversion 04:12:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:12:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:12:57 INFO - Cleaning up... 04:12:57 INFO - Return code: 0 04:12:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:12:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:12:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:12:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:12:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:12:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:12:57 INFO - Using env: {'DISPLAY': ':0', 04:12:57 INFO - 'HOME': '/home/cltbld', 04:12:57 INFO - 'LANG': 'en_US.UTF-8', 04:12:57 INFO - 'LANGUAGE': 'en_US:en', 04:12:57 INFO - 'LOGNAME': 'cltbld', 04:12:57 INFO - 'MAIL': '/var/mail/cltbld', 04:12:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:12:57 INFO - 'MOZ_NO_REMOTE': '1', 04:12:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:12:57 INFO - 'NO_EM_RESTART': '1', 04:12:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:12:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:12:57 INFO - 'PWD': '/builds/slave/test', 04:12:57 INFO - 'SHELL': '/bin/bash', 04:12:57 INFO - 'SHLVL': '1', 04:12:57 INFO - 'TERM': 'linux', 04:12:57 INFO - 'TMOUT': '86400', 04:12:57 INFO - 'USER': 'cltbld', 04:12:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:12:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:12:57 INFO - '_': '/tools/buildbot/bin/python'} 04:12:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:12:58 INFO - Running setup.py (path:/tmp/pip-bwJx3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:12:58 INFO - Running setup.py (path:/tmp/pip-NUBNMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:12:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:12:58 INFO - Running setup.py (path:/tmp/pip-CaBoJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:12:58 INFO - Running setup.py (path:/tmp/pip-E463Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:12:58 INFO - Running setup.py (path:/tmp/pip-rr1wRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:12:58 INFO - Running setup.py (path:/tmp/pip-LhHRgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:12:58 INFO - Running setup.py (path:/tmp/pip-Z2EB7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:12:58 INFO - Running setup.py (path:/tmp/pip-xF2DMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:12:58 INFO - Running setup.py (path:/tmp/pip-pFZybj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:12:58 INFO - Running setup.py (path:/tmp/pip-Z8gZvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:12:58 INFO - Running setup.py (path:/tmp/pip-HLj7ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:12:58 INFO - Running setup.py (path:/tmp/pip-6s_Sxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:12:58 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:12:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:12:58 INFO - Running setup.py (path:/tmp/pip-ieYw6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:12:59 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:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:12:59 INFO - Running setup.py (path:/tmp/pip-R9p1o8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:12:59 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:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:59 INFO - Running setup.py (path:/tmp/pip-ewjGd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:12:59 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:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:12:59 INFO - Running setup.py (path:/tmp/pip-kK4xNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:12:59 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:12:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:12:59 INFO - Running setup.py (path:/tmp/pip-j3gVcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:12:59 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:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:12:59 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:12:59 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:12:59 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:12:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:12:59 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:13:01 INFO - Downloading blessings-1.6.tar.gz 04:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:13:01 INFO - Installing collected packages: blessings 04:13:01 INFO - Running setup.py install for blessings 04:13:01 INFO - Successfully installed blessings 04:13:01 INFO - Cleaning up... 04:13:01 INFO - Return code: 0 04:13:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:01 INFO - Reading from file tmpfile_stdout 04:13:01 INFO - Current package versions: 04:13:01 INFO - argparse == 1.2.1 04:13:01 INFO - blessings == 1.6 04:13:01 INFO - blobuploader == 1.2.4 04:13:01 INFO - docopt == 0.6.1 04:13:01 INFO - manifestparser == 1.1 04:13:01 INFO - mozInstall == 1.12 04:13:01 INFO - mozcrash == 0.17 04:13:01 INFO - mozdebug == 0.1 04:13:01 INFO - mozdevice == 0.48 04:13:01 INFO - mozfile == 1.2 04:13:01 INFO - mozhttpd == 0.7 04:13:01 INFO - mozinfo == 0.9 04:13:01 INFO - mozleak == 0.1 04:13:01 INFO - mozlog == 3.1 04:13:01 INFO - moznetwork == 0.27 04:13:01 INFO - mozprocess == 0.22 04:13:01 INFO - mozprofile == 0.28 04:13:01 INFO - mozrunner == 6.11 04:13:01 INFO - mozscreenshot == 0.1 04:13:01 INFO - mozsystemmonitor == 0.0 04:13:01 INFO - moztest == 0.7 04:13:01 INFO - mozversion == 1.4 04:13:01 INFO - psutil == 3.1.1 04:13:01 INFO - requests == 1.2.3 04:13:01 INFO - wsgiref == 0.1.2 04:13:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:13:01 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:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 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:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:13:01 INFO - Using env: {'DISPLAY': ':0', 04:13:01 INFO - 'HOME': '/home/cltbld', 04:13:01 INFO - 'LANG': 'en_US.UTF-8', 04:13:01 INFO - 'LANGUAGE': 'en_US:en', 04:13:01 INFO - 'LOGNAME': 'cltbld', 04:13:01 INFO - 'MAIL': '/var/mail/cltbld', 04:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:01 INFO - 'MOZ_NO_REMOTE': '1', 04:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:01 INFO - 'NO_EM_RESTART': '1', 04:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:01 INFO - 'PWD': '/builds/slave/test', 04:13:01 INFO - 'SHELL': '/bin/bash', 04:13:01 INFO - 'SHLVL': '1', 04:13:01 INFO - 'TERM': 'linux', 04:13:01 INFO - 'TMOUT': '86400', 04:13:01 INFO - 'USER': 'cltbld', 04:13:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:01 INFO - '_': '/tools/buildbot/bin/python'} 04:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 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:13:01 INFO - Cleaning up... 04:13:01 INFO - Return code: 0 04:13:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:13:01 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:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 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:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:13:01 INFO - Using env: {'DISPLAY': ':0', 04:13:01 INFO - 'HOME': '/home/cltbld', 04:13:01 INFO - 'LANG': 'en_US.UTF-8', 04:13:01 INFO - 'LANGUAGE': 'en_US:en', 04:13:01 INFO - 'LOGNAME': 'cltbld', 04:13:01 INFO - 'MAIL': '/var/mail/cltbld', 04:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:01 INFO - 'MOZ_NO_REMOTE': '1', 04:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:01 INFO - 'NO_EM_RESTART': '1', 04:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:01 INFO - 'PWD': '/builds/slave/test', 04:13:01 INFO - 'SHELL': '/bin/bash', 04:13:01 INFO - 'SHLVL': '1', 04:13:01 INFO - 'TERM': 'linux', 04:13:01 INFO - 'TMOUT': '86400', 04:13:01 INFO - 'USER': 'cltbld', 04:13:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:01 INFO - '_': '/tools/buildbot/bin/python'} 04:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:02 INFO - Downloading/unpacking jsonschema 04:13:02 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:13:02 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:13:02 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:13:02 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:13:02 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:13:02 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:13:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:13:04 INFO - Downloading/unpacking functools32 (from jsonschema) 04:13:04 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:13:04 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:13:04 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:13:04 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:13:04 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:13:04 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:13:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:13:04 INFO - warning: no files found matching '*.txt' 04:13:04 INFO - no previously-included directories found matching 'build' 04:13:04 INFO - no previously-included directories found matching 'dist' 04:13:04 INFO - no previously-included directories found matching '.git*' 04:13:04 INFO - Installing collected packages: jsonschema, functools32 04:13:04 INFO - Running setup.py install for functools32 04:13:04 INFO - warning: no files found matching '*.txt' 04:13:04 INFO - no previously-included directories found matching 'build' 04:13:04 INFO - no previously-included directories found matching 'dist' 04:13:04 INFO - no previously-included directories found matching '.git*' 04:13:04 INFO - Successfully installed jsonschema functools32 04:13:04 INFO - Cleaning up... 04:13:04 INFO - Return code: 0 04:13:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53a8dcdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ce8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27995a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, '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-1467889950.309040-246410382', '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:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:13:04 INFO - Using env: {'DISPLAY': ':0', 04:13:04 INFO - 'HOME': '/home/cltbld', 04:13:04 INFO - 'LANG': 'en_US.UTF-8', 04:13:04 INFO - 'LANGUAGE': 'en_US:en', 04:13:04 INFO - 'LOGNAME': 'cltbld', 04:13:04 INFO - 'MAIL': '/var/mail/cltbld', 04:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:04 INFO - 'MOZ_NO_REMOTE': '1', 04:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:04 INFO - 'NO_EM_RESTART': '1', 04:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:04 INFO - 'PWD': '/builds/slave/test', 04:13:04 INFO - 'SHELL': '/bin/bash', 04:13:04 INFO - 'SHLVL': '1', 04:13:04 INFO - 'TERM': 'linux', 04:13:04 INFO - 'TMOUT': '86400', 04:13:04 INFO - 'USER': 'cltbld', 04:13:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:04 INFO - '_': '/tools/buildbot/bin/python'} 04:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:04 INFO - Downloading/unpacking flake8 04:13:04 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:13:04 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:13:04 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:13:04 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:13:04 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:13:04 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:13:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:13:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:13:06 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:13:06 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:13:06 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:13:06 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:13:06 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:13:06 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:13:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:13:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:13:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:07 INFO - no previously-included directories found matching 'docs/_build' 04:13:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:13:07 INFO - Running setup.py install for pep8 04:13:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:13:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:13:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:13:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:13:08 INFO - no previously-included directories found matching 'docs/_build' 04:13:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:13:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:13:08 INFO - Cleaning up... 04:13:08 INFO - Return code: 0 04:13:08 INFO - Running post-action listener: _resource_record_post_action 04:13:08 INFO - Running post-action listener: _start_resource_monitoring 04:13:08 INFO - Starting resource monitoring. 04:13:08 INFO - ##### 04:13:08 INFO - ##### Running install step. 04:13:08 INFO - ##### 04:13:08 INFO - Running pre-action listener: _resource_record_pre_action 04:13:08 INFO - Running main action method: install 04:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:13:08 INFO - Reading from file tmpfile_stdout 04:13:08 INFO - Detecting whether we're running mozinstall >=1.0... 04:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:13:08 INFO - Reading from file tmpfile_stdout 04:13:08 INFO - Output received: 04:13:08 INFO - Usage: mozinstall [options] installer 04:13:08 INFO - Options: 04:13:08 INFO - -h, --help show this help message and exit 04:13:08 INFO - -d DEST, --destination=DEST 04:13:08 INFO - Directory to install application into. [default: 04:13:08 INFO - "/builds/slave/test"] 04:13:08 INFO - --app=APP Application being installed. [default: firefox] 04:13:08 INFO - mkdir: /builds/slave/test/build/application 04:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:13:21 INFO - Reading from file tmpfile_stdout 04:13:21 INFO - Output received: 04:13:21 INFO - /builds/slave/test/build/application/firefox/firefox 04:13:21 INFO - Running post-action listener: _resource_record_post_action 04:13:21 INFO - ##### 04:13:21 INFO - ##### Running run-tests step. 04:13:21 INFO - ##### 04:13:21 INFO - Running pre-action listener: _resource_record_pre_action 04:13:21 INFO - Running main action method: run_tests 04:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:13:21 INFO - Python 2.7.3 04:13:21 INFO - Return code: 0 04:13:21 INFO - grabbing minidump binary from tooltool 04:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:21 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 0x2828410>, '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 0x2829310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28297a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:13:21 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:13:21 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:13:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:13:21 INFO - Return code: 0 04:13:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:13:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:13:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:13:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:13:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:13:22 INFO - Return code: 0 04:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.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:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.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:13:22 INFO - Using env: {'DISPLAY': ':0', 04:13:22 INFO - 'HOME': '/home/cltbld', 04:13:22 INFO - 'LANG': 'en_US.UTF-8', 04:13:22 INFO - 'LANGUAGE': 'en_US:en', 04:13:22 INFO - 'LOGNAME': 'cltbld', 04:13:22 INFO - 'MAIL': '/var/mail/cltbld', 04:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:22 INFO - 'MOZ_NO_REMOTE': '1', 04:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:22 INFO - 'NO_EM_RESTART': '1', 04:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:22 INFO - 'PWD': '/builds/slave/test', 04:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:13:22 INFO - 'SHELL': '/bin/bash', 04:13:22 INFO - 'SHLVL': '1', 04:13:22 INFO - 'TERM': 'linux', 04:13:22 INFO - 'TMOUT': '86400', 04:13:22 INFO - 'USER': 'cltbld', 04:13:22 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1467889950.309040-246410382', 04:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:22 INFO - '_': '/tools/buildbot/bin/python'} 04:13:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.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:13:22 INFO - mozversion application_buildid: 20160706215822 04:13:22 INFO - mozversion application_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:13:22 INFO - mozversion application_display_name: Firefox 04:13:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:13:22 INFO - mozversion application_name: Firefox 04:13:22 INFO - mozversion application_remotingname: firefox 04:13:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:13:22 INFO - mozversion application_vendor: Mozilla 04:13:22 INFO - mozversion application_version: 48.0 04:13:22 INFO - mozversion platform_buildid: 20160706215822 04:13:22 INFO - mozversion platform_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 04:13:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:13:22 INFO - mozversion platform_version: 48.0 04:13:22 INFO - using testdate: 1467890002 04:13:22 INFO - actual date: 1467890002 04:13:22 INFO - starting webserver on 'localhost:33871' 04:13:22 INFO - SUITE-START | Running 2 tests 04:13:22 INFO - TEST-START | dromaeo_css 04:13:22 INFO - operating with platform_type : linux_ 04:13:22 INFO - Initialising browser for dromaeo_css test... 04:13:22 INFO - TEST-INFO | started process 30283 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJvgWu/profile http://localhost:33871/getInfo.html) 04:13:26 INFO - PROCESS | 30283 | 04:13:26 INFO - PROCESS | 30283 | (process:30363): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:13:27 INFO - PROCESS | 30283 | __metrics Screen width/height:1600/1200 04:13:27 INFO - PROCESS | 30283 | colorDepth:24 04:13:27 INFO - PROCESS | 30283 | Browser inner width/height: 1024/697 04:13:27 INFO - PROCESS | 30283 | __metrics 04:13:27 ERROR - PROCESS | 30283 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:13:28 INFO - TEST-INFO | 30283: exit 0 04:13:28 INFO - Browser initialized. 04:13:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:13:28 INFO - TEST-INFO | started process 30413 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmJvgWu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:13:30 INFO - PROCESS | 30413 | 04:13:30 INFO - PROCESS | 30413 | (process:30484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:13:40 INFO - PROCESS | 30413 | RSS: Main: 151154688 04:13:40 INFO - PROCESS | 30413 | 04:14:29 INFO - PROCESS | 30413 | 1467890069875 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:16:37 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33871/tests/dromaeo/cssquery-ext.html) 04:16:38 INFO - PROCESS | 30413 | RSS: Main: 154316800 04:16:38 INFO - PROCESS | 30413 | 04:19:40 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-ext.html (next: http://localhost:33871/tests/dromaeo/cssquery-jquery.html) 04:19:40 INFO - PROCESS | 30413 | RSS: Main: 152928256 04:19:40 INFO - PROCESS | 30413 | 04:22:42 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33871/tests/dromaeo/cssquery-mootools.html) 04:22:43 INFO - PROCESS | 30413 | RSS: Main: 152342528 04:22:43 INFO - PROCESS | 30413 | 04:25:44 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33871/tests/dromaeo/cssquery-prototype.html) 04:25:45 INFO - PROCESS | 30413 | RSS: Main: 153366528 04:25:45 INFO - PROCESS | 30413 | 04:28:47 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33871/tests/dromaeo/cssquery-yui.html) 04:28:48 INFO - PROCESS | 30413 | RSS: Main: 152358912 04:28:48 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | Cycle 1(1): loaded http://localhost:33871/tests/dromaeo/cssquery-yui.html (next: http://localhost:33871/tests/dromaeo/cssquery-dojo.html) 04:31:50 INFO - PROCESS | 30413 | RSS: Main: 156467200 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | __start_tp_report 04:31:50 INFO - PROCESS | 30413 | _x_x_mozilla_page_load 04:31:50 INFO - PROCESS | 30413 | _x_x_mozilla_page_load_details 04:31:50 INFO - PROCESS | 30413 | |i|pagename|runs| 04:31:50 INFO - PROCESS | 30413 | |0;dojo.html;3262.4127657021736;3348.8158151301677;3366.276250606119;3401.3877502049622;3418.641042690517;5426.62013659044;5427.3215848018945;5433.429489903562;5459.808906688257;5461.1535212042145;5429.782808687648;5435.510804027636;5457.345118585766;5463.262459567957;5475.863103422416;4931.161702510564;4943.555080042795;4995.200767877141;5013.974930125362;5018.774155163026;4953.157963146274;5024.371953505812;5101.897962040757;5108.84673459795;5109.182530795074;4976.4774698656665;4981.352424184851;5026.371703537058;5070.366204224472;5075.137226671456;5080.949190508103;5099.056674515208;5115.514026167508;5118.692878427306;5146.922796158061;4883.340748998875;5030.698158110488;5040.6471546991725;5076.060928728197;5102.311187989611;5329.520343169133;5336.332958380202;5364.785408583691;5375.16684913839;5395.622306438551;5726.7995620153515;5761.251037365158;5767.567432442542;5783.450572195635;5784.595078344518;5679.744411501451;5777.740001699934;5793.4785869271545;5814.447627475383;5817.767289308423;5498.780048798043;5498.780048798083;5501.724913754297;5504.779808807642;5531.502164805187;5951.315598706117;5976.671283079472;6001.879962400815;6002.159697642333;6007.549433792483;5648.378678345379;5750.6837123958585;5767.538596912237;5775.931452681268;5843.24037875082;5904.704764761745;5905.763769449174;5906;5913.231279933667;5938.109283607407;5843.29880414353;5869.8239052828485;5876.588638795243;5882.117682347682;5895.94104058954;5722.170285308607;5851.882962340729;5889.087191485327;5926.436988486087;5934.19888315072;4517.638588912879;4523.932141017887;4531.886702832456;4540.182767101954;4546.954530454653;4079.551249362568;4079.796010199478;4084.0402505411203;4107.404426358221;4113.239050775616;5623.465770751772;5629.4652008059165;5672.971635141798;5720.227769251098;5774.191613174159;5779.248697669276;5825.7087145642545;5873.618214816109;5898.852528686817;5939.554533410012;5519.282493275929;5555.638883472561;5567.888642227133;5570.248016517799;5575.69333686643;4911.533404326583;4915.557599816034;4946.480619534969;4950.925736113961;4976.751162441863;6002.219711437572;6057.727402266821;6069.302030266487;6075.969620151959;6098.603590766586;5814.360420353673;5820.156077368673;5835.270591176103;5838.737256823369;5850.414958504116;6153.753849845956;6217.440430361289;6258.186435763321;6260.499160067093;6262.436380725757;5816.447437493432;5821.388754180919;5824.9417505826095;5832.912506312324;5835.183074369676;5787.565932554991;5829.358770535153;5844.386339434298;5883.558733094949;5889.705514724333;5709.65742055478;5725.312962444366;5745;5757.136429535603;5794.478496935296;5649.717514124195;5667.433256674464;5714.628549144292;5717.171010203414;5718.3423906249645;5604.747786349705;5608.298962629671;5627.296587926509;5646.124850648156;5696.231008813757;5727.627704199213;5749.1663708762835;5758.8848223034465;5759.827205183851;5768.653880767168;5580.051391263414;5660.349059858169;5660.632058916157;5661.745221464962;5663.263775709132 04:31:50 INFO - PROCESS | 30413 | |1;ext.html;664.6377724140343;682.361991537912;683.275727728608;732.8167958010494;742.0983505041376;39055.023624409405;40239.59760402395;40242;40552.59447405525;40557.188856222856;43567.3464898026;43939;43969.560304396946;44130.77934610323;44330;8868.778280542989;9012.68455604054;9069.183773460387;9070.86393704095;9087.545622718872;8790.824183516326;8882.378233523656;8888.333374996868;9091.909080909172;9109.089091090904;9134.26925845934;9227.077292270753;9233.984261731204;9247.306452016091;9248.815023699555;9160.221381182575;9172.541372931393;9173.128552787475;9192.540372981324;9210.447373157598;9223.861642075375;9256.30577706668;9263;9274.53627318638;9315.953420232856;43462;43972.34041489348;43995;44103;44289.77855110704;3567.30437564675;3694.6305369463107;3756.3614185588517;3763.755355901885;3826.521684789401;29469.41061178786;29547.704522954926;29721.25696857574;29772.255693607618;30295.697043029508;4363.716358436724;4376.627986621141;4382.715123516961;4396.670249731251;4455.6658250631335;276927;277672;278629.99999999796;280720;282169;39426;39827.60172398297;64707.352926471074;65192.348076518625;65351.673241633485;36700.265994679954;36871.81564092216;36902.8154859224;37016.25967480635;37069;16244.75632865508;16455.09496977654;16461.25924333408;16487.34050637961;16491.422800201934;12717.80923286133;12758.425870835834;12771.872281277068;12791.424385902657;12824.166429182073;9283.675071372469;9743.561539730728;9810.901890981142;9850.605975761033;9852.901470985198;3687.483752274684;3706.166112624692;3735.364987952055;3760.830762615689;3789.1853251551047;1125.921185517006;1142.942777930411;1191.2792760380019;1192.8091505359275;1236.208826351136;32636.510452343235;33117.3376532468;33176.83411582975;33255.334893301995;33330.83342083015;1189.5479717707217;1242.819791130299;1255.3409460033556;1286.6268782053287;1348.8044233586272;17053.48839534816;17358.65282694339;17470.09894666447;17567.297308107787;17719.114044297734;484219;490124;542050;806215;822540;62956;63793;63824.36175638277;63824.68087659532;63969.68015159894;1530.9436488822678;1535.4702627593463;1545.2428310127957;1562.437522491902;1568.725473042213;32451.837740811145;32802.83598581992;33271.66728332686;33338.33323333568;33840.83079584586;56699;56970.43029569651;57259.713701431225;57569;57663.423365765804;438808;440598;440823;440938;444646;30849.845750771103;31225.53161702531;31361.68638313679;31615;31861.36277274488;50735.746321268154;50819;50996.74501627468;51119.744401277756;52228;41104.58895411127;41148.38277425901;41715.7914210427;42216.577834221265;42877.3568396468;42009;42829.78585107055;43057.7847110775;43343.34984975165;43537;43396;43628.781856090514;44695.55304446914;44899.551004490844;44918.77540612276;35358.46962295619;36217;36945.26109477849;36954.815225923696;37397.065073373386;28648;28824;28935.276618084717;29147.71564227079;29394 04:31:50 INFO - PROCESS | 30413 | |2;jquery.html;417.56573163909536;422.6175311343234;424.3782858112865;433.5296203619073;437.5449532486214;16382.426615068474;18723.531911702197;19356;19409.514762130955;20404.387868363934;18875.244990200375;19407.32074377397;20097.196112155496;20123.698144527843;20396.796032039674;5203.063448579254;5233.241180028894;5393.406725260218;5396.892062158754;5409.648372855771;5290.65610735301;5378.731063446831;5408.675479471244;5421.2952316199035;5424.810131645393;5388.595855310848;5389.299391079174;5414.052540805344;5419.756110974996;5484.890302193954;5688.886222275572;5707.086866101404;5713.17159011943;5716.085426331809;5747.281589801275;5379.354477462691;5580.693061881595;5654.717264136777;5659.632123911973;5659.915101273484;14111.576652700436;14163.575092747235;14183.645408864757;14283.642908927257;14442;2359.8466099703464;2443.5357282116343;2506.949861002788;2690.6636670416196;2761.226856480189;9923.305368624198;10549.630762923261;10591.152707783358;10684.946575267151;10791.40647264408;1977.812107849752;2025.1494372363643;2128.648772952461;2154.9245776397906;2158.881261530615;73778;74653;74952.62523687401;75042;75060.62469687671;10857.2942758722;11215.271007384494;11227.438628068727;11619.186656934102;11786.5874694387;16367.2634731435;16431.424900128437;16528;16563;16579.17104144788;8499.36254780894;8526.65893364271;8775.912240877637;8820.5589720515;8872.512011839412;8366.874496882552;8559.443636163629;8812.427192232484;8818.11818818113;8852.247558957431;4896.95103048972;5024.246363045572;5048.066107770074;5052.545270925634;5072.365954255718;2097.888119296775;2122.4163355077167;2124.214040804912;2160.6758986152204;2183.268605017337;992.3797626483448;1130.5703832543745;1157.5022740221787;1167.7897978363806;1210.2435977514053;18744.812551874307;19076.80923190778;19270.32553860608;19696.803031969783;19699.901500492404;1041.1982773264695;1096.9341839489657;1103.332483847277;1142.8342890280862;1144.6737679761395;10818.188635852186;10972.396518191417;11080.722981925517;11110.61112861046;11168.81566380139;497943;507815;510414;520634;523761;88315.55842220748;88743.55628221818;90433;91215;93665.5316723412;1075.7525769073;1105.1379923659558;1106.623747925709;1112.9833052504218;1116.0457808573715;17080.97514149155;17115.486535403958;17222.91388543049;17286.04926729042;17405;34947.47578786371;37223.813880931506;39011;39342.21315573615;40045.39931900966;46099.53900460953;47563.28655070246;48532.75733621309;54650.72674636601;55120;8598;8863.556822158736;8882.911170888467;9073.954630226806;9140.268778497571;9368.4378937264;9727.708168754949;12468.688282793002;13313.201207927556;13466;12088.818667719815;12284.631461056182;12301.32342721159;12441.93779031099;12559.43482543306;11877;12004;12025.699357515781;12088.576899808464;12320.322382268703;12301.876981230072;12347.19743216688;12467.937660312004;12555.93722031384;12567.685807854878;8672.132786721277;8745.518996455;8868.467891926504;8869.334799890163;8935.642574296955;9038.774030649287;11630.883691163319;11978.161528692908;12135.757284854077;12214.450349734461 04:31:50 INFO - PROCESS | 30413 | |3;mootools.html;1581.2489067692848;1583.548688623742;1813.6735387630229;1913.301644899612;1923.1345894347546;7299.817504562388;8017.839643207132;8047.91952080479;8232.547209903452;8255.71105011324;8113.188681131898;8126.959365203165;8181.509109453437;8196.631151598178;8206.261436470717;2363.3500787283547;2374.715034195899;2380.2978121454125;2385.6183010718287;2389.7849193572574;2331.9533609327805;2349.107339211106;2359.8702071386065;2363.267387109993;2395.7364689884184;2328.7089113860766;2351.2240960483086;2360.3391050505884;2371.430856594422;2376.512814872947;2367.822413319008;2369.5853225685437;2398.3164798032562;2407.4462873539096;2414.263649586875;2370.656254843055;2372.3238876919995;2393.258089992108;2404.4950560382167;2409.4096946248105;8367.372447066433;8383.119772423868;8408;8427.41008129425;8444;5117.872053198663;5223.033738758342;5238.397584277819;5274.367075950872;5280.52475277223;3380.036689543468;3381.5603971483797;3387.339468803584;3397.575303087114;3461.7403694722743;1100.9944950275278;1123.634818683931;1132.1112926352855;1133.3313345126414;1136.8237923121928;11508.079353651689;11532.308061516336;11570.479328430241;11594.47824847884;11607.07143428532;4502.774861256924;4519.683622146484;4549.272116461417;4593.908121837611;4618.584327410549;9895.851562226573;9906.80186396268;9914;9920.454375009444;9936.850947235796;5292.52367286946;5312.256284120226;5329.333833270841;5340.813071542478;5359.22291267764;4651.558101980307;4705.788239529229;4719.38647975761;4757.548032936866;4878.585320247818;3777.395616701315;3789.8105094745706;3806.5051543299196;3845.3655146900446;3860.1700634363747;1169.602335206034;1187.768385164902;1188.815733561282;1192.838966739479;1195.5456926367924;955.7132860141929;1044.99477502612;1045.3936716704293;1051.6214162901501;1065.408698172506;5802.796902108406;6059.151718759377;6160.445559899541;6195.473384762346;6327.335629758901;1045.6810672744887;1066.7546464313252;1076.8976947190004;1095.2223921016168;1095.271644356494;3952.8418863245147;4009.578994205625;4036.697247706375;4047.615476529725;4058;9864.210863130933;10087.394756314497;10289.897101029044;10300.124489418484;10300.175985921109;10090.747731306776;10135.7466063349;10212.08091271789;10218.693439196835;10227.335223210468;7996.32031277348;8043.718469853527;8061.999999999883;8073.798155046171;8101.594920253964;5885.705714714161;5895.882082358243;5903.557233207613;5951.434613711691;6052;8707.434016788888;8883.0228674847;8954.865677014981;9064.456132632064;9088.136627020422;8789.692360767342;9024.503652298923;9037.322200834833;9110.043445438134;9264.305177111879;7232.602206878672;7274.127104747464;7293.452991025801;7426.071741032371;7452.664630091551;7621.885671715039;7633.427492938163;7651.693932242871;7690.038745156856;7724.0731112266885;7115.644217788987;7270.9636451817405;7338.633068346669;7366.6684999174095;7418.109826820816;7021.648917554;7094.077769889881;7148.606826624586;7156.320149585781;7159.7136114556915;6574.704138313692;6817.795466136024;6837.897431538431;6842.521023528305;6843.623600702009;4978.701277923336;5090.592752579711;5106.66806657566;5115.590752739698;5162.97418512905;5007.799688012438;5010.977657238814;5050.217216331474;5096.694198347963;5138.717370544656 04:31:50 INFO - PROCESS | 30413 | |4;prototype.html;345.4265918575167;348.17656242985316;353.6534196487442;354.5851353915918;357.5334188883506;6428.2928877823515;6433.260175079861;6441.32366101559;6466.579672321296;6512.218533775942;6420.0048992406255;6437.35626437356;6439.130717353168;6443.226812782473;6455.354464553554;4747.976260118695;4845.152098382787;4890.315355850184;4893.339399181101;4933.703977761345;4909.950900490985;4918.606511479091;4920.753962301888;4922.753862306889;4943.802247910079;4870.439899411577;4872.634552408584;4874.073925954075;4878.609711223094;4888.291197776321;4877.097736918681;4890.046440944017;4890.168671325883;4899.559039686445;4913.557779799799;4292.914141717149;4294.248506511348;4294.312909934395;4297.505786834523;4307.3108302671735;6110.602810817327;6218.720157592919;6221.595596286227;6249.625022498664;6260.248770147611;5637.746301416405;5644.943550564483;5650.660960342351;5679.716014199274;5693.060644993571;6741.528093033489;6752.426043786235;6779.966100169468;6796.864062718767;6807.115075040213;4734.786934587917;4738.976305118486;4741.834035808764;4745.264484004984;4747.572718455321;7106.715731370739;7174.139103307636;7178.49750517464;7184.38932690722;7195.2444993276;4698.459677137173;4846.5638092571835;4854.757262136879;4910.729909854921;4911.607071434277;4876.146674332049;4896.2410826321975;4914.975425122923;4919.237518184687;4929.235968424829;5703.344115426696;5707.34365547959;5746.9712651436475;5759.510441612426;5763.711814409263;6918.5502942308585;6939.895901561481;6940.375366217065;6944.930550694529;6946.652667366611;1708.4618345221215;1746.3713063297203;1749.553863764732;1751.1856986501339;1751.7897852257556;1120.171073405674;1143.5140065472308;1146.2950285574311;1152.6772503698978;1163.7381589142544;6705.396514313735;6715.832104197337;6716.429103526255;6727.596344219264;6732.259451460335;7118.323759242864;7119.288071192839;7132.857342853114;7143.42852571793;7144.535605185646;6579.47364210862;6794.048833163361;6796.388325050671;6808.319168083152;6810.489213308922;3813.122981714221;3861.6524512793985;3867.16855875988;3896.7661940283674;3899.2786334528205;7592.8861067084035;7607.695692172251;7609.581473018927;7611.314981651567;7617.200193979663;7234.240404757425;7363.963180184065;7366.558006519626;7371.447141464304;7377.741779037708;7520.09758828944;7591.3926885849;7592.962035189788;7592.962035189899;7617.314441700273;7126;7141.750038748619;7153.4992550520965;7164.9641751790905;7176.174739904769;7077.469189810682;7089.042979197742;7094.077769889881;7098;7108.680109395193;7397.704091836482;7549.660265288185;7571.46999710015;7592.8481430372185;7599.886001709868;4824.372831532019;4848.75756212195;4870;4874.658773885936;4879.682820616648;7111.60886151246;7118.608476533634;7118.857622847618;7119.181294151032;7122.394596459359;6951.721931122698;6951.721931122901;6952.200496942714;6955.6869940851775;6956.582605043714;6680.899786503303;6875.690593923186;6919.238883722887;6939.201991770809;6945.652717364011;6736.124303840469;6770.6614669265355;6795.082663840516;6802.659867006729;6807.217170025312;6901.62041087745;6940.41006514452;6963.199232088172;6963.582185068912;6967.65161741921;6766.594004359754;6778.830529236809;6793.388595026471;6826.556273842184;6831.658417079226 04:31:50 INFO - PROCESS | 30413 | |5;yui.html;830.4560512864074;895.7223260789156;901.1754244865944;914.5107367558358;923.7136487688815;14256.073355231903;14496.347664355102;14523.41906323747;14557.053791503546;14582.125072495644;11647.592334268302;13024.088313818036;13036.869631303683;13048.151870128435;13059.085863989525;886.0563499872632;905.1265528764741;905.4702998745742;913;913.5934509143434;888.7911340834899;893.1247377569986;894.1773568317163;899.3389858454032;900.0999000999001;950.8431108867029;952.4618590496382;952.6094301336453;954.0364232125534;955.4888134847857;923.5659240157115;924.2328867040408;948.170350942925;949.0699114867434;950.0689324462031;689.7241103558616;690.7651398524475;692.1866806502389;693.930606939307;696.1646024770246;14061.64845878851;14145.363458644386;14221.786673199807;14229.217393043378;14251.714965700732;14544.927275363556;14579.271036448241;14593.489227876973;14700.632484187874;14716.411343546246;11238.66284011481;11356.375399353032;11440.485178167002;11448.427578621118;11650.6504804856;3953.150072734376;3959.5644479107277;4041;4044.4539987101657;4110.588941105895;52533.21200182;52953.47046529524;53342.73328633371;55146.17280740792;55433;11488.827667584992;11520.942395288137;11696.122790790725;11776.94111529454;12022.218555793845;20227.98860056991;20323.390298291073;20356.083976221107;20368.388948331572;20371;8598.183172598594;8773.122687731176;8866.583019657037;8933.731988040368;9227.630894764268;4705.835295764632;4759.6668233223345;4780.7654797683235;4822.599027517163;4843.346148270009;3614.0784100054316;3724.832382542792;3728.496652951817;3752.4371344298575;3756.436534519844;642.142739442849;644.1851058411114;647.8250872264463;659.0871642774696;677.6408503493157;747.312472525278;799.8360336131079;806.899137607799;808.0303635637259;813.4305985809839;9497.810043799085;9677.274204434696;9736.221102311798;9812.313138080266;9924.37058413764;806.6168569929354;817.358373676661;832.6211573733937;833.4124442268186;836.9665213391396;4099.733517321364;4454.265046267395;4493.842715504941;4503.88740281489;4516.638668906479;63163.36836631667;63955.36044639494;65250;65475.67262163754;66103.33896660972;57288.42711572831;57905;58158.7092064537;58296;58353.416465835646;50421.747891261046;51069.23396149061;51854;52047.47952520502;53294.934101317755;8841.381103322705;9019.323550733852;9175.678851240174;9220.538973051454;9242.584083716114;36894.631053690195;37051;37770.05574860651;38583.61416385912;38782;44006.779966099966;44435.33346999862;46219.306710400044;46711.53288467072;47007;12568.371581421075;12680.112392132462;12824.743505130033;12894.67763305925;13089.934550327187;13292.800607990694;13538.526151584647;14136.646583835487;14353.282335882956;14452.349644265823;13037.543685970946;13296.135751176143;13437.193768373929;14237.50168744089;14246.857531424554;13998.930005349908;14045.438182472586;14056.086354386933;14138.151710897379;14221.928890355483;13090.083694141318;13253.734925301633;13387.933060334635;13585.864141358856;13887;10797;10885.129189664965;10913.727156821144;10978.451077445936;11127.944360278147;11603.800748632495;11605.593804216813;11632.069434445055;11657.941710291394;11739 04:31:50 INFO - PROCESS | 30413 | __end_tp_report 04:31:50 INFO - PROCESS | 30413 | __start_cc_report 04:31:50 INFO - PROCESS | 30413 | _x_x_mozilla_cycle_collect,320 04:31:50 INFO - PROCESS | 30413 | __end_cc_report 04:31:50 INFO - PROCESS | 30413 | __startTimestamp1467891110626__endTimestamp 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | ------- Summary: start ------- 04:31:50 INFO - PROCESS | 30413 | Number of tests: 6 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#0] dojo.html Cycles:165 Average:5460.75 Median:5663.26 stddev:588.18 (10.4%) stddev-sans-first:564.13 04:31:50 INFO - PROCESS | 30413 | Values: 3262.4 3348.8 3366.3 3401.4 3418.6 5426.6 5427.3 5433.4 5459.8 5461.2 5429.8 5435.5 5457.3 5463.3 5475.9 4931.2 4943.6 4995.2 5014.0 5018.8 4953.2 5024.4 5101.9 5108.8 5109.2 4976.5 4981.4 5026.4 5070.4 5075.1 5080.9 5099.1 5115.5 5118.7 5146.9 4883.3 5030.7 5040.6 5076.1 5102.3 5329.5 5336.3 5364.8 5375.2 5395.6 5726.8 5761.3 5767.6 5783.5 5784.6 5679.7 5777.7 5793.5 5814.4 5817.8 5498.8 5498.8 5501.7 5504.8 5531.5 5951.3 5976.7 6001.9 6002.2 6007.5 5648.4 5750.7 5767.5 5775.9 5843.2 5904.7 5905.8 5906.0 5913.2 5938.1 5843.3 5869.8 5876.6 5882.1 5895.9 5722.2 5851.9 5889.1 5926.4 5934.2 4517.6 4523.9 4531.9 4540.2 4547.0 4079.6 4079.8 4084.0 4107.4 4113.2 5623.5 5629.5 5673.0 5720.2 5774.2 5779.2 5825.7 5873.6 5898.9 5939.6 5519.3 5555.6 5567.9 5570.2 5575.7 4911.5 4915.6 4946.5 4950.9 4976.8 6002.2 6057.7 6069.3 6076.0 6098.6 5814.4 5820.2 5835.3 5838.7 5850.4 6153.8 6217.4 6258.2 6260.5 6262.4 5816.4 5821.4 5824.9 5832.9 5835.2 5787.6 5829.4 5844.4 5883.6 5889.7 5709.7 5725.3 5745.0 5757.1 5794.5 5649.7 5667.4 5714.6 5717.2 5718.3 5604.7 5608.3 5627.3 5646.1 5696.2 5727.6 5749.2 5758.9 5759.8 5768.7 5580.1 5660.3 5660.6 5661.7 5663.3 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#1] ext.html Cycles:180 Average:60609.79 Median:42112.79 stddev:128639.84 (305.5%) stddev-sans-first:128921.97 04:31:50 INFO - PROCESS | 30413 | Values: 664.6 682.4 683.3 732.8 742.1 39055.0 40239.6 40242.0 40552.6 40557.2 43567.3 43939.0 43969.6 44130.8 44330.0 8868.8 9012.7 9069.2 9070.9 9087.5 8790.8 8882.4 8888.3 9091.9 9109.1 9134.3 9227.1 9234.0 9247.3 9248.8 9160.2 9172.5 9173.1 9192.5 9210.4 9223.9 9256.3 9263.0 9274.5 9316.0 43462.0 43972.3 43995.0 44103.0 44289.8 3567.3 3694.6 3756.4 3763.8 3826.5 29469.4 29547.7 29721.3 29772.3 30295.7 4363.7 4376.6 4382.7 4396.7 4455.7 276927.0 277672.0 278630.0 280720.0 282169.0 39426.0 39827.6 64707.4 65192.3 65351.7 36700.3 36871.8 36902.8 37016.3 37069.0 16244.8 16455.1 16461.3 16487.3 16491.4 12717.8 12758.4 12771.9 12791.4 12824.2 9283.7 9743.6 9810.9 9850.6 9852.9 3687.5 3706.2 3735.4 3760.8 3789.2 1125.9 1142.9 1191.3 1192.8 1236.2 32636.5 33117.3 33176.8 33255.3 33330.8 1189.5 1242.8 1255.3 1286.6 1348.8 17053.5 17358.7 17470.1 17567.3 17719.1 484219.0 490124.0 542050.0 806215.0 822540.0 62956.0 63793.0 63824.4 63824.7 63969.7 1530.9 1535.5 1545.2 1562.4 1568.7 32451.8 32802.8 33271.7 33338.3 33840.8 56699.0 56970.4 57259.7 57569.0 57663.4 438808.0 440598.0 440823.0 440938.0 444646.0 30849.8 31225.5 31361.7 31615.0 31861.4 50735.7 50819.0 50996.7 51119.7 52228.0 41104.6 41148.4 41715.8 42216.6 42877.4 42009.0 42829.8 43057.8 43343.3 43537.0 43396.0 43628.8 44695.6 44899.6 44918.8 35358.5 36217.0 36945.3 36954.8 37397.1 28648.0 28824.0 28935.3 29147.7 29394.0 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#2] jquery.html Cycles:180 Average:28960.61 Median:2401.69 stddev:84134.08 (3503.1%) stddev-sans-first:84342.81 04:31:50 INFO - PROCESS | 30413 | Values: 417.6 422.6 424.4 433.5 437.5 16382.4 18723.5 19356.0 19409.5 20404.4 18875.2 19407.3 20097.2 20123.7 20396.8 5203.1 5233.2 5393.4 5396.9 5409.6 5290.7 5378.7 5408.7 5421.3 5424.8 5388.6 5389.3 5414.1 5419.8 5484.9 5688.9 5707.1 5713.2 5716.1 5747.3 5379.4 5580.7 5654.7 5659.6 5659.9 14111.6 14163.6 14183.6 14283.6 14442.0 2359.8 2443.5 2506.9 2690.7 2761.2 9923.3 10549.6 10591.2 10684.9 10791.4 1977.8 2025.1 2128.6 2154.9 2158.9 73778.0 74653.0 74952.6 75042.0 75060.6 10857.3 11215.3 11227.4 11619.2 11786.6 16367.3 16431.4 16528.0 16563.0 16579.2 8499.4 8526.7 8775.9 8820.6 8872.5 8366.9 8559.4 8812.4 8818.1 8852.2 4897.0 5024.2 5048.1 5052.5 5072.4 2097.9 2122.4 2124.2 2160.7 2183.3 992.4 1130.6 1157.5 1167.8 1210.2 18744.8 19076.8 19270.3 19696.8 19699.9 1041.2 1096.9 1103.3 1142.8 1144.7 10818.2 10972.4 11080.7 11110.6 11168.8 497943.0 507815.0 510414.0 520634.0 523761.0 88315.6 88743.6 90433.0 91215.0 93665.5 1075.8 1105.1 1106.6 1113.0 1116.0 17081.0 17115.5 17222.9 17286.0 17405.0 34947.5 37223.8 39011.0 39342.2 40045.4 46099.5 47563.3 48532.8 54650.7 55120.0 8598.0 8863.6 8882.9 9074.0 9140.3 9368.4 9727.7 12468.7 13313.2 13466.0 12088.8 12284.6 12301.3 12441.9 12559.4 11877.0 12004.0 12025.7 12088.6 12320.3 12301.9 12347.2 12467.9 12555.9 12567.7 8672.1 8745.5 8868.5 8869.3 8935.6 9038.8 11630.9 11978.2 12135.8 12214.5 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#3] mootools.html Cycles:180 Average:5554.38 Median:5030.60 stddev:2990.80 (59.5%) stddev-sans-first:2984.29 04:31:50 INFO - PROCESS | 30413 | Values: 1581.2 1583.5 1813.7 1913.3 1923.1 7299.8 8017.8 8047.9 8232.5 8255.7 8113.2 8127.0 8181.5 8196.6 8206.3 2363.4 2374.7 2380.3 2385.6 2389.8 2332.0 2349.1 2359.9 2363.3 2395.7 2328.7 2351.2 2360.3 2371.4 2376.5 2367.8 2369.6 2398.3 2407.4 2414.3 2370.7 2372.3 2393.3 2404.5 2409.4 8367.4 8383.1 8408.0 8427.4 8444.0 5117.9 5223.0 5238.4 5274.4 5280.5 3380.0 3381.6 3387.3 3397.6 3461.7 1101.0 1123.6 1132.1 1133.3 1136.8 11508.1 11532.3 11570.5 11594.5 11607.1 4502.8 4519.7 4549.3 4593.9 4618.6 9895.9 9906.8 9914.0 9920.5 9936.9 5292.5 5312.3 5329.3 5340.8 5359.2 4651.6 4705.8 4719.4 4757.5 4878.6 3777.4 3789.8 3806.5 3845.4 3860.2 1169.6 1187.8 1188.8 1192.8 1195.5 955.7 1045.0 1045.4 1051.6 1065.4 5802.8 6059.2 6160.4 6195.5 6327.3 1045.7 1066.8 1076.9 1095.2 1095.3 3952.8 4009.6 4036.7 4047.6 4058.0 9864.2 10087.4 10289.9 10300.1 10300.2 10090.7 10135.7 10212.1 10218.7 10227.3 7996.3 8043.7 8062.0 8073.8 8101.6 5885.7 5895.9 5903.6 5951.4 6052.0 8707.4 8883.0 8954.9 9064.5 9088.1 8789.7 9024.5 9037.3 9110.0 9264.3 7232.6 7274.1 7293.5 7426.1 7452.7 7621.9 7633.4 7651.7 7690.0 7724.1 7115.6 7271.0 7338.6 7366.7 7418.1 7021.6 7094.1 7148.6 7156.3 7159.7 6574.7 6817.8 6837.9 6842.5 6843.6 4978.7 5090.6 5106.7 5115.6 5163.0 5007.8 5011.0 5050.2 5096.7 5138.7 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#4] prototype.html Cycles:180 Average:5780.62 Median:6630.19 stddev:1772.18 (26.7%) stddev-sans-first:1729.56 04:31:50 INFO - PROCESS | 30413 | Values: 345.4 348.2 353.7 354.6 357.5 6428.3 6433.3 6441.3 6466.6 6512.2 6420.0 6437.4 6439.1 6443.2 6455.4 4748.0 4845.2 4890.3 4893.3 4933.7 4910.0 4918.6 4920.8 4922.8 4943.8 4870.4 4872.6 4874.1 4878.6 4888.3 4877.1 4890.0 4890.2 4899.6 4913.6 4292.9 4294.2 4294.3 4297.5 4307.3 6110.6 6218.7 6221.6 6249.6 6260.2 5637.7 5644.9 5650.7 5679.7 5693.1 6741.5 6752.4 6780.0 6796.9 6807.1 4734.8 4739.0 4741.8 4745.3 4747.6 7106.7 7174.1 7178.5 7184.4 7195.2 4698.5 4846.6 4854.8 4910.7 4911.6 4876.1 4896.2 4915.0 4919.2 4929.2 5703.3 5707.3 5747.0 5759.5 5763.7 6918.6 6939.9 6940.4 6944.9 6946.7 1708.5 1746.4 1749.6 1751.2 1751.8 1120.2 1143.5 1146.3 1152.7 1163.7 6705.4 6715.8 6716.4 6727.6 6732.3 7118.3 7119.3 7132.9 7143.4 7144.5 6579.5 6794.0 6796.4 6808.3 6810.5 3813.1 3861.7 3867.2 3896.8 3899.3 7592.9 7607.7 7609.6 7611.3 7617.2 7234.2 7364.0 7366.6 7371.4 7377.7 7520.1 7591.4 7593.0 7593.0 7617.3 7126.0 7141.8 7153.5 7165.0 7176.2 7077.5 7089.0 7094.1 7098.0 7108.7 7397.7 7549.7 7571.5 7592.8 7599.9 4824.4 4848.8 4870.0 4874.7 4879.7 7111.6 7118.6 7118.9 7119.2 7122.4 6951.7 6951.7 6952.2 6955.7 6956.6 6680.9 6875.7 6919.2 6939.2 6945.7 6736.1 6770.7 6795.1 6802.7 6807.2 6901.6 6940.4 6963.2 6963.6 6967.7 6766.6 6778.8 6793.4 6826.6 6831.7 04:31:50 INFO - PROCESS | 30413 | 04:31:50 INFO - PROCESS | 30413 | [#5] yui.html Cycles:180 Average:15392.97 Median:4510.26 stddev:17622.97 (390.7%) stddev-sans-first:17638.47 04:31:50 INFO - PROCESS | 30413 | Values: 830.5 895.7 901.2 914.5 923.7 14256.1 14496.3 14523.4 14557.1 14582.1 11647.6 13024.1 13036.9 13048.2 13059.1 886.1 905.1 905.5 913.0 913.6 888.8 893.1 894.2 899.3 900.1 950.8 952.5 952.6 954.0 955.5 923.6 924.2 948.2 949.1 950.1 689.7 690.8 692.2 693.9 696.2 14061.6 14145.4 14221.8 14229.2 14251.7 14544.9 14579.3 14593.5 14700.6 14716.4 11238.7 11356.4 11440.5 11448.4 11650.7 3953.2 3959.6 4041.0 4044.5 4110.6 52533.2 52953.5 53342.7 55146.2 55433.0 11488.8 11520.9 11696.1 11776.9 12022.2 20228.0 20323.4 20356.1 20368.4 20371.0 8598.2 8773.1 8866.6 8933.7 9227.6 4705.8 4759.7 4780.8 4822.6 4843.3 3614.1 3724.8 3728.5 3752.4 3756.4 642.1 644.2 647.8 659.1 677.6 747.3 799.8 806.9 808.0 813.4 9497.8 9677.3 9736.2 9812.3 9924.4 806.6 817.4 832.6 833.4 837.0 4099.7 4454.3 4493.8 4503.9 4516.6 63163.4 63955.4 65250.0 65475.7 66103.3 57288.4 57905.0 58158.7 58296.0 58353.4 50421.7 51069.2 51854.0 52047.5 53294.9 8841.4 9019.3 9175.7 9220.5 9242.6 36894.6 37051.0 37770.1 38583.6 38782.0 44006.8 44435.3 46219.3 46711.5 47007.0 12568.4 12680.1 12824.7 12894.7 13089.9 13292.8 13538.5 14136.6 14353.3 14452.3 13037.5 13296.1 13437.2 14237.5 14246.9 13998.9 14045.4 14056.1 14138.2 14221.9 13090.1 13253.7 13387.9 13585.9 13887.0 10797.0 10885.1 10913.7 10978.5 11127.9 11603.8 11605.6 11632.1 11657.9 11739.0 04:31:50 INFO - PROCESS | 30413 | -------- Summary: end -------- 04:31:50 INFO - PROCESS | 30413 | 04:31:51 INFO - TEST-INFO | 30413: exit 0 04:31:51 INFO - TEST-OK | dromaeo_css | took 1108428ms 04:31:51 INFO - TEST-START | kraken 04:31:51 INFO - operating with platform_type : linux_ 04:31:51 INFO - Initialising browser for kraken test... 04:31:51 INFO - TEST-INFO | started process 30658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWjGam/profile http://localhost:33871/getInfo.html) 04:31:54 INFO - PROCESS | 30658 | 04:31:54 INFO - PROCESS | 30658 | (process:30736): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:31:55 INFO - PROCESS | 30658 | __metrics Screen width/height:1600/1200 04:31:55 INFO - PROCESS | 30658 | colorDepth:24 04:31:55 INFO - PROCESS | 30658 | Browser inner width/height: 1024/697 04:31:55 INFO - PROCESS | 30658 | __metrics 04:31:56 ERROR - PROCESS | 30658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:31:57 INFO - TEST-INFO | 30658: exit 0 04:31:57 INFO - Browser initialized. 04:31:57 INFO - Running cycle 1/1 for kraken test... 04:31:57 INFO - TEST-INFO | started process 30786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFWjGam/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:31:58 INFO - PROCESS | 30786 | 04:31:58 INFO - PROCESS | 30786 | (process:30855): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:32:08 INFO - PROCESS | 30786 | RSS: Main: 150581248 04:32:08 INFO - PROCESS | 30786 | 04:32:11 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33871/tests/kraken/driver.html?testName=audio-beat-detection) 04:32:12 INFO - PROCESS | 30786 | RSS: Main: 155623424 04:32:12 INFO - PROCESS | 30786 | 04:32:14 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33871/tests/kraken/driver.html?testName=audio-dft) 04:32:15 INFO - PROCESS | 30786 | RSS: Main: 155734016 04:32:15 INFO - PROCESS | 30786 | 04:32:18 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33871/tests/kraken/driver.html?testName=audio-fft) 04:32:18 INFO - PROCESS | 30786 | RSS: Main: 156225536 04:32:18 INFO - PROCESS | 30786 | 04:32:21 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33871/tests/kraken/driver.html?testName=audio-oscillator) 04:32:21 INFO - PROCESS | 30786 | RSS: Main: 155856896 04:32:21 INFO - PROCESS | 30786 | 04:32:23 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33871/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:32:24 INFO - PROCESS | 30786 | RSS: Main: 155947008 04:32:24 INFO - PROCESS | 30786 | 04:32:27 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33871/tests/kraken/driver.html?testName=imaging-darkroom) 04:32:28 INFO - PROCESS | 30786 | RSS: Main: 156082176 04:32:28 INFO - PROCESS | 30786 | 04:32:31 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33871/tests/kraken/driver.html?testName=imaging-desaturate) 04:32:32 INFO - PROCESS | 30786 | RSS: Main: 156319744 04:32:32 INFO - PROCESS | 30786 | 04:32:34 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33871/tests/kraken/driver.html?testName=json-parse-financial) 04:32:35 INFO - PROCESS | 30786 | RSS: Main: 156041216 04:32:35 INFO - PROCESS | 30786 | 04:32:37 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33871/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:32:37 INFO - PROCESS | 30786 | RSS: Main: 155721728 04:32:37 INFO - PROCESS | 30786 | 04:32:39 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:32:39 INFO - PROCESS | 30786 | RSS: Main: 155938816 04:32:39 INFO - PROCESS | 30786 | 04:32:41 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:32:42 INFO - PROCESS | 30786 | RSS: Main: 156459008 04:32:42 INFO - PROCESS | 30786 | 04:32:45 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:32:45 INFO - PROCESS | 30786 | RSS: Main: 157204480 04:32:45 INFO - PROCESS | 30786 | 04:32:48 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:32:49 INFO - PROCESS | 30786 | RSS: Main: 157061120 04:32:49 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | Cycle 1(1): loaded http://localhost:33871/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33871/tests/kraken/driver.html?testName=ai-astar) 04:32:50 INFO - PROCESS | 30786 | RSS: Main: 158416896 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | __start_tp_report 04:32:50 INFO - PROCESS | 30786 | _x_x_mozilla_page_load 04:32:50 INFO - PROCESS | 30786 | _x_x_mozilla_page_load_details 04:32:50 INFO - PROCESS | 30786 | |i|pagename|runs| 04:32:50 INFO - PROCESS | 30786 | |0;ai-astar;108;111;104;109;111;110;103;110;109;111 04:32:50 INFO - PROCESS | 30786 | |1;audio-beat-detection;168;124;155;176;127;151;150;131;190;128 04:32:50 INFO - PROCESS | 30786 | |2;audio-dft;161;162;164;162;161;161;160;161;163;164 04:32:50 INFO - PROCESS | 30786 | |3;audio-fft;77;74;77;199;76;72;73;76;185;75 04:32:50 INFO - PROCESS | 30786 | |4;audio-oscillator;93;93;149;93;94;92;140;92;92;142 04:32:50 INFO - PROCESS | 30786 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;117;118;117 04:32:50 INFO - PROCESS | 30786 | |6;imaging-darkroom;147;152;146;147;147;147;146;147;146;146 04:32:50 INFO - PROCESS | 30786 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;95 04:32:50 INFO - PROCESS | 30786 | |8;json-parse-financial;55;56;60;58;57;56;57;79;60;54 04:32:50 INFO - PROCESS | 30786 | |9;json-stringify-tinderbox;58;63;58;58;59;58;58;59;59;58 04:32:50 INFO - PROCESS | 30786 | |10;stanford-crypto-aes;75;79;73;74;74;74;74;75;78;74 04:32:50 INFO - PROCESS | 30786 | |11;stanford-crypto-ccm;122;116;117;113;115;121;112;121;128;130 04:32:50 INFO - PROCESS | 30786 | |12;stanford-crypto-pbkdf2;157;158;158;160;159;162;167;158;158;161 04:32:50 INFO - PROCESS | 30786 | |13;stanford-crypto-sha256-iterative;68;67;67;67;69;68;68;67;66;65 04:32:50 INFO - PROCESS | 30786 | __end_tp_report 04:32:50 INFO - PROCESS | 30786 | __start_cc_report 04:32:50 INFO - PROCESS | 30786 | _x_x_mozilla_cycle_collect,814 04:32:50 INFO - PROCESS | 30786 | __end_cc_report 04:32:50 INFO - PROCESS | 30786 | __startTimestamp1467891170941__endTimestamp 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | ------- Summary: start ------- 04:32:50 INFO - PROCESS | 30786 | Number of tests: 14 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#0] ai-astar Cycles:10 Average:108.60 Median:110.00 stddev:2.88 (2.6%) stddev-sans-first:3.04 04:32:50 INFO - PROCESS | 30786 | Values: 108.0 111.0 104.0 109.0 111.0 110.0 103.0 110.0 109.0 111.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#1] audio-beat-detection Cycles:10 Average:150.00 Median:153.00 stddev:22.79 (14.9%) stddev-sans-first:23.23 04:32:50 INFO - PROCESS | 30786 | Values: 168.0 124.0 155.0 176.0 127.0 151.0 150.0 131.0 190.0 128.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.41 04:32:50 INFO - PROCESS | 30786 | Values: 161.0 162.0 164.0 162.0 161.0 161.0 160.0 161.0 163.0 164.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#3] audio-fft Cycles:10 Average:98.40 Median:75.50 stddev:49.47 (65.5%) stddev-sans-first:51.86 04:32:50 INFO - PROCESS | 30786 | Values: 77.0 74.0 77.0 199.0 76.0 72.0 73.0 76.0 185.0 75.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:92.50 stddev:24.72 (26.7%) stddev-sans-first:25.62 04:32:50 INFO - PROCESS | 30786 | Values: 93.0 93.0 149.0 93.0 94.0 92.0 140.0 92.0 92.0 142.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 04:32:50 INFO - PROCESS | 30786 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.79 (1.2%) stddev-sans-first:1.90 04:32:50 INFO - PROCESS | 30786 | Values: 147.0 152.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:32:50 INFO - PROCESS | 30786 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#8] json-parse-financial Cycles:10 Average:59.20 Median:57.50 stddev:7.22 (12.6%) stddev-sans-first:7.50 04:32:50 INFO - PROCESS | 30786 | Values: 55.0 56.0 60.0 58.0 57.0 56.0 57.0 79.0 60.0 54.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:1.55 (2.6%) stddev-sans-first:1.62 04:32:50 INFO - PROCESS | 30786 | Values: 58.0 63.0 58.0 58.0 59.0 58.0 58.0 59.0 59.0 58.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:1.94 (2.6%) stddev-sans-first:2.06 04:32:50 INFO - PROCESS | 30786 | Values: 75.0 79.0 73.0 74.0 74.0 74.0 74.0 75.0 78.0 74.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#11] stanford-crypto-ccm Cycles:10 Average:119.50 Median:121.00 stddev:6.06 (5.0%) stddev-sans-first:6.36 04:32:50 INFO - PROCESS | 30786 | Values: 122.0 116.0 117.0 113.0 115.0 121.0 112.0 121.0 128.0 130.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:159.50 stddev:2.97 (1.9%) stddev-sans-first:2.98 04:32:50 INFO - PROCESS | 30786 | Values: 157.0 158.0 158.0 160.0 159.0 162.0 167.0 158.0 158.0 161.0 04:32:50 INFO - PROCESS | 30786 | 04:32:50 INFO - PROCESS | 30786 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.14 (1.7%) stddev-sans-first:1.17 04:32:50 INFO - PROCESS | 30786 | Values: 68.0 67.0 67.0 67.0 69.0 68.0 68.0 67.0 66.0 65.0 04:32:50 INFO - PROCESS | 30786 | -------- Summary: end -------- 04:32:50 INFO - PROCESS | 30786 | 04:32:51 INFO - TEST-INFO | 30786: exit 0 04:32:51 INFO - TEST-OK | kraken | took 60536ms 04:32:51 INFO - SUITE-END | took 1168s 04:32:52 INFO - Completed test suite (00:19:29) 04:32:52 INFO - javascript benchmark 04:32:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3262.4127657021736, 3348.8158151301677, 3366.276250606119, 3401.3877502049622, 3418.641042690517, 5426.62013659044, 5427.3215848018945, 5433.429489903562, 5459.808906688257, 5461.1535212042145, 5429.782808687648, 5435.510804027636, 5457.345118585766, 5463.262459567957, 5475.863103422416, 4931.161702510564, 4943.555080042795, 4995.200767877141, 5013.974930125362, 5018.774155163026, 4953.157963146274, 5024.371953505812, 5101.897962040757, 5108.84673459795, 5109.182530795074, 4976.4774698656665, 4981.352424184851, 5026.371703537058, 5070.366204224472, 5075.137226671456, 5080.949190508103, 5099.056674515208, 5115.514026167508, 5118.692878427306, 5146.922796158061, 4883.340748998875, 5030.698158110488, 5040.6471546991725, 5076.060928728197, 5102.311187989611, 5329.520343169133, 5336.332958380202, 5364.785408583691, 5375.16684913839, 5395.622306438551, 5726.7995620153515, 5761.251037365158, 5767.567432442542, 5783.450572195635, 5784.595078344518, 5679.744411501451, 5777.740001699934, 5793.4785869271545, 5814.447627475383, 5817.767289308423, 5498.780048798043, 5498.780048798083, 5501.724913754297, 5504.779808807642, 5531.502164805187, 5951.315598706117, 5976.671283079472, 6001.879962400815, 6002.159697642333, 6007.549433792483, 5648.378678345379, 5750.6837123958585, 5767.538596912237, 5775.931452681268, 5843.24037875082, 5904.704764761745, 5905.763769449174, 5906.0, 5913.231279933667, 5938.109283607407, 5843.29880414353, 5869.8239052828485, 5876.588638795243, 5882.117682347682, 5895.94104058954, 5722.170285308607, 5851.882962340729, 5889.087191485327, 5926.436988486087, 5934.19888315072, 4517.638588912879, 4523.932141017887, 4531.886702832456, 4540.182767101954, 4546.954530454653, 4079.551249362568, 4079.796010199478, 4084.0402505411203, 4107.404426358221, 4113.239050775616, 5623.465770751772, 5629.4652008059165, 5672.971635141798, 5720.227769251098, 5774.191613174159, 5779.248697669276, 5825.7087145642545, 5873.618214816109, 5898.852528686817, 5939.554533410012, 5519.282493275929, 5555.638883472561, 5567.888642227133, 5570.248016517799, 5575.69333686643, 4911.533404326583, 4915.557599816034, 4946.480619534969, 4950.925736113961, 4976.751162441863, 6002.219711437572, 6057.727402266821, 6069.302030266487, 6075.969620151959, 6098.603590766586, 5814.360420353673, 5820.156077368673, 5835.270591176103, 5838.737256823369, 5850.414958504116, 6153.753849845956, 6217.440430361289, 6258.186435763321, 6260.499160067093, 6262.436380725757, 5816.447437493432, 5821.388754180919, 5824.9417505826095, 5832.912506312324, 5835.183074369676, 5787.565932554991, 5829.358770535153, 5844.386339434298, 5883.558733094949, 5889.705514724333, 5709.65742055478, 5725.312962444366, 5745.0, 5757.136429535603, 5794.478496935296, 5649.717514124195, 5667.433256674464, 5714.628549144292, 5717.171010203414, 5718.3423906249645, 5604.747786349705, 5608.298962629671, 5627.296587926509, 5646.124850648156, 5696.231008813757, 5727.627704199213, 5749.1663708762835, 5758.8848223034465, 5759.827205183851, 5768.653880767168, 5580.051391263414, 5660.349059858169, 5660.632058916157, 5661.745221464962, 5663.263775709132], "value": 5423.953454912371, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.6377724140343, 682.361991537912, 683.275727728608, 732.8167958010494, 742.0983505041376, 39055.023624409405, 40239.59760402395, 40242.0, 40552.59447405525, 40557.188856222856, 43567.3464898026, 43939.0, 43969.560304396946, 44130.77934610323, 44330.0, 8868.778280542989, 9012.68455604054, 9069.183773460387, 9070.86393704095, 9087.545622718872, 8790.824183516326, 8882.378233523656, 8888.333374996868, 9091.909080909172, 9109.089091090904, 9134.26925845934, 9227.077292270753, 9233.984261731204, 9247.306452016091, 9248.815023699555, 9160.221381182575, 9172.541372931393, 9173.128552787475, 9192.540372981324, 9210.447373157598, 9223.861642075375, 9256.30577706668, 9263.0, 9274.53627318638, 9315.953420232856, 43462.0, 43972.34041489348, 43995.0, 44103.0, 44289.77855110704, 3567.30437564675, 3694.6305369463107, 3756.3614185588517, 3763.755355901885, 3826.521684789401, 29469.41061178786, 29547.704522954926, 29721.25696857574, 29772.255693607618, 30295.697043029508, 4363.716358436724, 4376.627986621141, 4382.715123516961, 4396.670249731251, 4455.6658250631335, 276927.0, 277672.0, 278629.99999999796, 280720.0, 282169.0, 39426.0, 39827.60172398297, 64707.352926471074, 65192.348076518625, 65351.673241633485, 36700.265994679954, 36871.81564092216, 36902.8154859224, 37016.25967480635, 37069.0, 16244.75632865508, 16455.09496977654, 16461.25924333408, 16487.34050637961, 16491.422800201934, 12717.80923286133, 12758.425870835834, 12771.872281277068, 12791.424385902657, 12824.166429182073, 9283.675071372469, 9743.561539730728, 9810.901890981142, 9850.605975761033, 9852.901470985198, 3687.483752274684, 3706.166112624692, 3735.364987952055, 3760.830762615689, 3789.1853251551047, 1125.921185517006, 1142.942777930411, 1191.2792760380019, 1192.8091505359275, 1236.208826351136, 32636.510452343235, 33117.3376532468, 33176.83411582975, 33255.334893301995, 33330.83342083015, 1189.5479717707217, 1242.819791130299, 1255.3409460033556, 1286.6268782053287, 1348.8044233586272, 17053.48839534816, 17358.65282694339, 17470.09894666447, 17567.297308107787, 17719.114044297734, 484219.0, 490124.0, 542050.0, 806215.0, 822540.0, 62956.0, 63793.0, 63824.36175638277, 63824.68087659532, 63969.68015159894, 1530.9436488822678, 1535.4702627593463, 1545.2428310127957, 1562.437522491902, 1568.725473042213, 32451.837740811145, 32802.83598581992, 33271.66728332686, 33338.33323333568, 33840.83079584586, 56699.0, 56970.43029569651, 57259.713701431225, 57569.0, 57663.423365765804, 438808.0, 440598.0, 440823.0, 440938.0, 444646.0, 30849.845750771103, 31225.53161702531, 31361.68638313679, 31615.0, 31861.36277274488, 50735.746321268154, 50819.0, 50996.74501627468, 51119.744401277756, 52228.0, 41104.58895411127, 41148.38277425901, 41715.7914210427, 42216.577834221265, 42877.3568396468, 42009.0, 42829.78585107055, 43057.7847110775, 43343.34984975165, 43537.0, 43396.0, 43628.781856090514, 44695.55304446914, 44899.551004490844, 44918.77540612276, 35358.46962295619, 36217.0, 36945.26109477849, 36954.815225923696, 37397.065073373386, 28648.0, 28824.0, 28935.276618084717, 29147.71564227079, 29394.0], "value": 19752.041568387096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.56573163909536, 422.6175311343234, 424.3782858112865, 433.5296203619073, 437.5449532486214, 16382.426615068474, 18723.531911702197, 19356.0, 19409.514762130955, 20404.387868363934, 18875.244990200375, 19407.32074377397, 20097.196112155496, 20123.698144527843, 20396.796032039674, 5203.063448579254, 5233.241180028894, 5393.406725260218, 5396.892062158754, 5409.648372855771, 5290.65610735301, 5378.731063446831, 5408.675479471244, 5421.2952316199035, 5424.810131645393, 5388.595855310848, 5389.299391079174, 5414.052540805344, 5419.756110974996, 5484.890302193954, 5688.886222275572, 5707.086866101404, 5713.17159011943, 5716.085426331809, 5747.281589801275, 5379.354477462691, 5580.693061881595, 5654.717264136777, 5659.632123911973, 5659.915101273484, 14111.576652700436, 14163.575092747235, 14183.645408864757, 14283.642908927257, 14442.0, 2359.8466099703464, 2443.5357282116343, 2506.949861002788, 2690.6636670416196, 2761.226856480189, 9923.305368624198, 10549.630762923261, 10591.152707783358, 10684.946575267151, 10791.40647264408, 1977.812107849752, 2025.1494372363643, 2128.648772952461, 2154.9245776397906, 2158.881261530615, 73778.0, 74653.0, 74952.62523687401, 75042.0, 75060.62469687671, 10857.2942758722, 11215.271007384494, 11227.438628068727, 11619.186656934102, 11786.5874694387, 16367.2634731435, 16431.424900128437, 16528.0, 16563.0, 16579.17104144788, 8499.36254780894, 8526.65893364271, 8775.912240877637, 8820.5589720515, 8872.512011839412, 8366.874496882552, 8559.443636163629, 8812.427192232484, 8818.11818818113, 8852.247558957431, 4896.95103048972, 5024.246363045572, 5048.066107770074, 5052.545270925634, 5072.365954255718, 2097.888119296775, 2122.4163355077167, 2124.214040804912, 2160.6758986152204, 2183.268605017337, 992.3797626483448, 1130.5703832543745, 1157.5022740221787, 1167.7897978363806, 1210.2435977514053, 18744.812551874307, 19076.80923190778, 19270.32553860608, 19696.803031969783, 19699.901500492404, 1041.1982773264695, 1096.9341839489657, 1103.332483847277, 1142.8342890280862, 1144.6737679761395, 10818.188635852186, 10972.396518191417, 11080.722981925517, 11110.61112861046, 11168.81566380139, 497943.0, 507815.0, 510414.0, 520634.0, 523761.0, 88315.55842220748, 88743.55628221818, 90433.0, 91215.0, 93665.5316723412, 1075.7525769073, 1105.1379923659558, 1106.623747925709, 1112.9833052504218, 1116.0457808573715, 17080.97514149155, 17115.486535403958, 17222.91388543049, 17286.04926729042, 17405.0, 34947.47578786371, 37223.813880931506, 39011.0, 39342.21315573615, 40045.39931900966, 46099.53900460953, 47563.28655070246, 48532.75733621309, 54650.72674636601, 55120.0, 8598.0, 8863.556822158736, 8882.911170888467, 9073.954630226806, 9140.268778497571, 9368.4378937264, 9727.708168754949, 12468.688282793002, 13313.201207927556, 13466.0, 12088.818667719815, 12284.631461056182, 12301.32342721159, 12441.93779031099, 12559.43482543306, 11877.0, 12004.0, 12025.699357515781, 12088.576899808464, 12320.322382268703, 12301.876981230072, 12347.19743216688, 12467.937660312004, 12555.93722031384, 12567.685807854878, 8672.132786721277, 8745.518996455, 8868.467891926504, 8869.334799890163, 8935.642574296955, 9038.774030649287, 11630.883691163319, 11978.161528692908, 12135.757284854077, 12214.450349734461], "value": 9259.160013473973, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1581.2489067692848, 1583.548688623742, 1813.6735387630229, 1913.301644899612, 1923.1345894347546, 7299.817504562388, 8017.839643207132, 8047.91952080479, 8232.547209903452, 8255.71105011324, 8113.188681131898, 8126.959365203165, 8181.509109453437, 8196.631151598178, 8206.261436470717, 2363.3500787283547, 2374.715034195899, 2380.2978121454125, 2385.6183010718287, 2389.7849193572574, 2331.9533609327805, 2349.107339211106, 2359.8702071386065, 2363.267387109993, 2395.7364689884184, 2328.7089113860766, 2351.2240960483086, 2360.3391050505884, 2371.430856594422, 2376.512814872947, 2367.822413319008, 2369.5853225685437, 2398.3164798032562, 2407.4462873539096, 2414.263649586875, 2370.656254843055, 2372.3238876919995, 2393.258089992108, 2404.4950560382167, 2409.4096946248105, 8367.372447066433, 8383.119772423868, 8408.0, 8427.41008129425, 8444.0, 5117.872053198663, 5223.033738758342, 5238.397584277819, 5274.367075950872, 5280.52475277223, 3380.036689543468, 3381.5603971483797, 3387.339468803584, 3397.575303087114, 3461.7403694722743, 1100.9944950275278, 1123.634818683931, 1132.1112926352855, 1133.3313345126414, 1136.8237923121928, 11508.079353651689, 11532.308061516336, 11570.479328430241, 11594.47824847884, 11607.07143428532, 4502.774861256924, 4519.683622146484, 4549.272116461417, 4593.908121837611, 4618.584327410549, 9895.851562226573, 9906.80186396268, 9914.0, 9920.454375009444, 9936.850947235796, 5292.52367286946, 5312.256284120226, 5329.333833270841, 5340.813071542478, 5359.22291267764, 4651.558101980307, 4705.788239529229, 4719.38647975761, 4757.548032936866, 4878.585320247818, 3777.395616701315, 3789.8105094745706, 3806.5051543299196, 3845.3655146900446, 3860.1700634363747, 1169.602335206034, 1187.768385164902, 1188.815733561282, 1192.838966739479, 1195.5456926367924, 955.7132860141929, 1044.99477502612, 1045.3936716704293, 1051.6214162901501, 1065.408698172506, 5802.796902108406, 6059.151718759377, 6160.445559899541, 6195.473384762346, 6327.335629758901, 1045.6810672744887, 1066.7546464313252, 1076.8976947190004, 1095.2223921016168, 1095.271644356494, 3952.8418863245147, 4009.578994205625, 4036.697247706375, 4047.615476529725, 4058.0, 9864.210863130933, 10087.394756314497, 10289.897101029044, 10300.124489418484, 10300.175985921109, 10090.747731306776, 10135.7466063349, 10212.08091271789, 10218.693439196835, 10227.335223210468, 7996.32031277348, 8043.718469853527, 8061.999999999883, 8073.798155046171, 8101.594920253964, 5885.705714714161, 5895.882082358243, 5903.557233207613, 5951.434613711691, 6052.0, 8707.434016788888, 8883.0228674847, 8954.865677014981, 9064.456132632064, 9088.136627020422, 8789.692360767342, 9024.503652298923, 9037.322200834833, 9110.043445438134, 9264.305177111879, 7232.602206878672, 7274.127104747464, 7293.452991025801, 7426.071741032371, 7452.664630091551, 7621.885671715039, 7633.427492938163, 7651.693932242871, 7690.038745156856, 7724.0731112266885, 7115.644217788987, 7270.9636451817405, 7338.633068346669, 7366.6684999174095, 7418.109826820816, 7021.648917554, 7094.077769889881, 7148.606826624586, 7156.320149585781, 7159.7136114556915, 6574.704138313692, 6817.795466136024, 6837.897431538431, 6842.521023528305, 6843.623600702009, 4978.701277923336, 5090.592752579711, 5106.66806657566, 5115.590752739698, 5162.97418512905, 5007.799688012438, 5010.977657238814, 5050.217216331474, 5096.694198347963, 5138.717370544656], "value": 4549.974939026286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.4265918575167, 348.17656242985316, 353.6534196487442, 354.5851353915918, 357.5334188883506, 6428.2928877823515, 6433.260175079861, 6441.32366101559, 6466.579672321296, 6512.218533775942, 6420.0048992406255, 6437.35626437356, 6439.130717353168, 6443.226812782473, 6455.354464553554, 4747.976260118695, 4845.152098382787, 4890.315355850184, 4893.339399181101, 4933.703977761345, 4909.950900490985, 4918.606511479091, 4920.753962301888, 4922.753862306889, 4943.802247910079, 4870.439899411577, 4872.634552408584, 4874.073925954075, 4878.609711223094, 4888.291197776321, 4877.097736918681, 4890.046440944017, 4890.168671325883, 4899.559039686445, 4913.557779799799, 4292.914141717149, 4294.248506511348, 4294.312909934395, 4297.505786834523, 4307.3108302671735, 6110.602810817327, 6218.720157592919, 6221.595596286227, 6249.625022498664, 6260.248770147611, 5637.746301416405, 5644.943550564483, 5650.660960342351, 5679.716014199274, 5693.060644993571, 6741.528093033489, 6752.426043786235, 6779.966100169468, 6796.864062718767, 6807.115075040213, 4734.786934587917, 4738.976305118486, 4741.834035808764, 4745.264484004984, 4747.572718455321, 7106.715731370739, 7174.139103307636, 7178.49750517464, 7184.38932690722, 7195.2444993276, 4698.459677137173, 4846.5638092571835, 4854.757262136879, 4910.729909854921, 4911.607071434277, 4876.146674332049, 4896.2410826321975, 4914.975425122923, 4919.237518184687, 4929.235968424829, 5703.344115426696, 5707.34365547959, 5746.9712651436475, 5759.510441612426, 5763.711814409263, 6918.5502942308585, 6939.895901561481, 6940.375366217065, 6944.930550694529, 6946.652667366611, 1708.4618345221215, 1746.3713063297203, 1749.553863764732, 1751.1856986501339, 1751.7897852257556, 1120.171073405674, 1143.5140065472308, 1146.2950285574311, 1152.6772503698978, 1163.7381589142544, 6705.396514313735, 6715.832104197337, 6716.429103526255, 6727.596344219264, 6732.259451460335, 7118.323759242864, 7119.288071192839, 7132.857342853114, 7143.42852571793, 7144.535605185646, 6579.47364210862, 6794.048833163361, 6796.388325050671, 6808.319168083152, 6810.489213308922, 3813.122981714221, 3861.6524512793985, 3867.16855875988, 3896.7661940283674, 3899.2786334528205, 7592.8861067084035, 7607.695692172251, 7609.581473018927, 7611.314981651567, 7617.200193979663, 7234.240404757425, 7363.963180184065, 7366.558006519626, 7371.447141464304, 7377.741779037708, 7520.09758828944, 7591.3926885849, 7592.962035189788, 7592.962035189899, 7617.314441700273, 7126.0, 7141.750038748619, 7153.4992550520965, 7164.9641751790905, 7176.174739904769, 7077.469189810682, 7089.042979197742, 7094.077769889881, 7098.0, 7108.680109395193, 7397.704091836482, 7549.660265288185, 7571.46999710015, 7592.8481430372185, 7599.886001709868, 4824.372831532019, 4848.75756212195, 4870.0, 4874.658773885936, 4879.682820616648, 7111.60886151246, 7118.608476533634, 7118.857622847618, 7119.181294151032, 7122.394596459359, 6951.721931122698, 6951.721931122901, 6952.200496942714, 6955.6869940851775, 6956.582605043714, 6680.899786503303, 6875.690593923186, 6919.238883722887, 6939.201991770809, 6945.652717364011, 6736.124303840469, 6770.6614669265355, 6795.082663840516, 6802.659867006729, 6807.217170025312, 6901.62041087745, 6940.41006514452, 6963.199232088172, 6963.582185068912, 6967.65161741921, 6766.594004359754, 6778.830529236809, 6793.388595026471, 6826.556273842184, 6831.658417079226], "value": 5198.68223556448, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.4560512864074, 895.7223260789156, 901.1754244865944, 914.5107367558358, 923.7136487688815, 14256.073355231903, 14496.347664355102, 14523.41906323747, 14557.053791503546, 14582.125072495644, 11647.592334268302, 13024.088313818036, 13036.869631303683, 13048.151870128435, 13059.085863989525, 886.0563499872632, 905.1265528764741, 905.4702998745742, 913.0, 913.5934509143434, 888.7911340834899, 893.1247377569986, 894.1773568317163, 899.3389858454032, 900.0999000999001, 950.8431108867029, 952.4618590496382, 952.6094301336453, 954.0364232125534, 955.4888134847857, 923.5659240157115, 924.2328867040408, 948.170350942925, 949.0699114867434, 950.0689324462031, 689.7241103558616, 690.7651398524475, 692.1866806502389, 693.930606939307, 696.1646024770246, 14061.64845878851, 14145.363458644386, 14221.786673199807, 14229.217393043378, 14251.714965700732, 14544.927275363556, 14579.271036448241, 14593.489227876973, 14700.632484187874, 14716.411343546246, 11238.66284011481, 11356.375399353032, 11440.485178167002, 11448.427578621118, 11650.6504804856, 3953.150072734376, 3959.5644479107277, 4041.0, 4044.4539987101657, 4110.588941105895, 52533.21200182, 52953.47046529524, 53342.73328633371, 55146.17280740792, 55433.0, 11488.827667584992, 11520.942395288137, 11696.122790790725, 11776.94111529454, 12022.218555793845, 20227.98860056991, 20323.390298291073, 20356.083976221107, 20368.388948331572, 20371.0, 8598.183172598594, 8773.122687731176, 8866.583019657037, 8933.731988040368, 9227.630894764268, 4705.835295764632, 4759.6668233223345, 4780.7654797683235, 4822.599027517163, 4843.346148270009, 3614.0784100054316, 3724.832382542792, 3728.496652951817, 3752.4371344298575, 3756.436534519844, 642.142739442849, 644.1851058411114, 647.8250872264463, 659.0871642774696, 677.6408503493157, 747.312472525278, 799.8360336131079, 806.899137607799, 808.0303635637259, 813.4305985809839, 9497.810043799085, 9677.274204434696, 9736.221102311798, 9812.313138080266, 9924.37058413764, 806.6168569929354, 817.358373676661, 832.6211573733937, 833.4124442268186, 836.9665213391396, 4099.733517321364, 4454.265046267395, 4493.842715504941, 4503.88740281489, 4516.638668906479, 63163.36836631667, 63955.36044639494, 65250.0, 65475.67262163754, 66103.33896660972, 57288.42711572831, 57905.0, 58158.7092064537, 58296.0, 58353.416465835646, 50421.747891261046, 51069.23396149061, 51854.0, 52047.47952520502, 53294.934101317755, 8841.381103322705, 9019.323550733852, 9175.678851240174, 9220.538973051454, 9242.584083716114, 36894.631053690195, 37051.0, 37770.05574860651, 38583.61416385912, 38782.0, 44006.779966099966, 44435.33346999862, 46219.306710400044, 46711.53288467072, 47007.0, 12568.371581421075, 12680.112392132462, 12824.743505130033, 12894.67763305925, 13089.934550327187, 13292.800607990694, 13538.526151584647, 14136.646583835487, 14353.282335882956, 14452.349644265823, 13037.543685970946, 13296.135751176143, 13437.193768373929, 14237.50168744089, 14246.857531424554, 13998.930005349908, 14045.438182472586, 14056.086354386933, 14138.151710897379, 14221.928890355483, 13090.083694141318, 13253.734925301633, 13387.933060334635, 13585.864141358856, 13887.0, 10797.0, 10885.129189664965, 10913.727156821144, 10978.451077445936, 11127.944360278147, 11603.800748632495, 11605.593804216813, 11632.069434445055, 11657.941710291394, 11739.0], "value": 7137.6552135849115, "unit": "score"}], "name": "dromaeo_css", "value": 7424.476989556, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 104.0, 109.0, 111.0, 110.0, 103.0, 110.0, 109.0, 111.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 124.0, 155.0, 176.0, 127.0, 151.0, 150.0, 131.0, 190.0, 128.0], "value": 150.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 164.0, 162.0, 161.0, 161.0, 160.0, 161.0, 163.0, 164.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 77.0, 199.0, 76.0, 72.0, 73.0, 76.0, 185.0, 75.0], "value": 98.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 149.0, 93.0, 94.0, 92.0, 140.0, 92.0, 92.0, 142.0], "value": 108.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 60.0, 58.0, 57.0, 56.0, 57.0, 79.0, 60.0, 54.0], "value": 59.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 58.0, 58.0, 59.0, 58.0, 58.0, 59.0, 59.0, 58.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 73.0, 74.0, 74.0, 74.0, 74.0, 75.0, 78.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 117.0, 113.0, 115.0, 121.0, 112.0, 121.0, 128.0, 130.0], "value": 119.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 158.0, 160.0, 159.0, 162.0, 167.0, 158.0, 158.0, 161.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 68.0, 67.0, 66.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1525.6999999999998, "alertThreshold": 2.0}]} 04:32:52 INFO - Return code: 0 04:32:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:32:52 ERROR - # TBPL SUCCESS # 04:32:52 INFO - Running post-action listener: _resource_record_post_action 04:32:52 INFO - Running post-run listener: _resource_record_post_run 04:32:53 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 24576; Write bytes: 431476736; Read time: 20; Write time: 398028 04:32:53 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 209592320; Read time: 0; Write time: 245172 04:32:53 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 221884416; Read time: 0; Write time: 152856 04:32:53 INFO - Running post-run listener: _upload_blobber_files 04:32:53 INFO - Blob upload gear active. 04:32:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:32:53 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:32:53 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:32:53 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:32:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:54 INFO - (blobuploader) - INFO - Done attempting. 04:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:32:55 INFO - (blobuploader) - INFO - Done attempting. 04:32:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:32:55 INFO - Return code: 0 04:32:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:32:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:32:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ab2ac6b8187b9764a56410d01180d376ce0d868e2ba83b8dca3497d0af5d8e9a4ec3d81505221a7bcd7c212fa7534a65b7bb77dad1e40a7b8d5082f9a3d184", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/577c5871922c401a26151c31e71b920658782f787a92ed7c74e53b6e66ed1d07f79d076418d873a79feb3612162e2131da43d88a80fa4686c7c783b3ff4dfb53"} 04:32:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:32:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:32:55 INFO - Contents: 04:32:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ab2ac6b8187b9764a56410d01180d376ce0d868e2ba83b8dca3497d0af5d8e9a4ec3d81505221a7bcd7c212fa7534a65b7bb77dad1e40a7b8d5082f9a3d184", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/577c5871922c401a26151c31e71b920658782f787a92ed7c74e53b6e66ed1d07f79d076418d873a79feb3612162e2131da43d88a80fa4686c7c783b3ff4dfb53"} 04:32:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:32:55 INFO - Copying logs to upload dir... 04:32:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:32:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1223.217362 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 23 secs) (at 2016-07-07 04:32:55.243414) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:32:55.247097) ========= 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-1467889950.309040-246410382 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/Mozilla-Beta/sha512/56ab2ac6b8187b9764a56410d01180d376ce0d868e2ba83b8dca3497d0af5d8e9a4ec3d81505221a7bcd7c212fa7534a65b7bb77dad1e40a7b8d5082f9a3d184", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/577c5871922c401a26151c31e71b920658782f787a92ed7c74e53b6e66ed1d07f79d076418d873a79feb3612162e2131da43d88a80fa4686c7c783b3ff4dfb53"} build_url:https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/56ab2ac6b8187b9764a56410d01180d376ce0d868e2ba83b8dca3497d0af5d8e9a4ec3d81505221a7bcd7c212fa7534a65b7bb77dad1e40a7b8d5082f9a3d184", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/577c5871922c401a26151c31e71b920658782f787a92ed7c74e53b6e66ed1d07f79d076418d873a79feb3612162e2131da43d88a80fa4686c7c783b3ff4dfb53"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 04:32:55.277748) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:32:55.278161) ========= 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-1467889950.309040-246410382 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 04:32:55.362919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:32:55.363378) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 04:32:55.363746) ========= ========= Total master_lag: 0.18 =========