builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1467877020.82 results: success (0) buildid: 20160706215822 builduid: 005acac198204b229cc2500b323a4168 revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:00.823484) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:00.823892) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:00.824159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:00.842615) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:00.842900) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 00:37:00-- 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% 59.7M=0s 2016-07-07 00:37:01 (59.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150136 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.007386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.007708) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014905 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.057427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.057787) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 00:37:01,183 truncating revision to first 12 chars 2016-07-07 00:37:01,183 Setting DEBUG logging. 2016-07-07 00:37:01,183 attempt 1/10 2016-07-07 00:37:01,183 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 00:37:01,493 unpacking tar archive at: mozilla-beta-d142c49033c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632310 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.703583) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.703890) ========= script_repo_revision: d142c49033c015f67272562b37dbe2912cfc7f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.704289) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.704568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 00:37:01.713469) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-07 00:37:01.713845) ========= /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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:37:01 INFO - MultiFileLogger online at 20160707 00:37:01 in /builds/slave/test 00:37:01 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 00:37:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:37:01 INFO - {'append_to_log': False, 00:37:01 INFO - 'base_work_dir': '/builds/slave/test', 00:37:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 00:37:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:37:01 INFO - 'branch': 'Mozilla-Beta', 00:37:01 INFO - 'buildbot_json_path': 'buildprops.json', 00:37:01 INFO - 'config_files': ('talos/linux_config.py',), 00:37:01 INFO - 'default_actions': ('clobber', 00:37:01 INFO - 'read-buildbot-config', 00:37:01 INFO - 'download-and-extract', 00:37:01 INFO - 'populate-webroot', 00:37:01 INFO - 'create-virtualenv', 00:37:01 INFO - 'install', 00:37:01 INFO - 'run-tests'), 00:37:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:37:01 INFO - 'download_minidump_stackwalk': True, 00:37:01 INFO - 'download_symbols': 'ondemand', 00:37:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:37:01 INFO - 'tooltool.py': '/tools/tooltool.py', 00:37:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:37:01 INFO - '/tools/misc-python/virtualenv.py')}, 00:37:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:37:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:37:01 INFO - 'installer_path': 'installer.exe', 00:37:01 INFO - 'log_level': 'info', 00:37:01 INFO - 'log_name': 'talos', 00:37:01 INFO - 'log_to_console': True, 00:37:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:37:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:37:01 INFO - 'opt_config_files': (), 00:37:01 INFO - 'pip_index': False, 00:37:01 INFO - 'sps_profile': False, 00:37:01 INFO - 'sps_profile_interval': 0, 00:37:01 INFO - 'suite': 'dromaeojs-e10s', 00:37:01 INFO - 'system_bits': '32', 00:37:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:37:01 INFO - 'title': 'talos-linux64-ix-002', 00:37:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:37:01 INFO - 'use_talos_json': True, 00:37:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:37:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:37:01 INFO - 'work_dir': 'build'} 00:37:01 INFO - ##### 00:37:01 INFO - ##### Running clobber step. 00:37:01 INFO - ##### 00:37:01 INFO - Running pre-action listener: _resource_record_pre_action 00:37:01 INFO - Running main action method: clobber 00:37:01 INFO - rmtree: /builds/slave/test/build 00:37:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:37:02 INFO - Running post-action listener: _resource_record_post_action 00:37:02 INFO - ##### 00:37:02 INFO - ##### Running read-buildbot-config step. 00:37:02 INFO - ##### 00:37:02 INFO - Running pre-action listener: _resource_record_pre_action 00:37:02 INFO - Running main action method: read_buildbot_config 00:37:02 INFO - Using buildbot properties: 00:37:02 INFO - { 00:37:02 INFO - "project": "", 00:37:02 INFO - "product": "firefox", 00:37:02 INFO - "script_repo_revision": "production", 00:37:02 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 00:37:02 INFO - "repository": "", 00:37:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 00:37:02 INFO - "buildid": "20160706215822", 00:37:02 INFO - "pgo_build": "True", 00:37:02 INFO - "basedir": "/builds/slave/test", 00:37:02 INFO - "buildnumber": 85, 00:37:02 INFO - "slavename": "talos-linux64-ix-002", 00:37:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:37:02 INFO - "platform": "ubuntu64_hw", 00:37:02 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 00:37:02 INFO - "branch": "mozilla-beta", 00:37:02 INFO - "repo_path": "releases/mozilla-beta", 00:37:02 INFO - "revision": "d142c49033c015f67272562b37dbe2912cfc7f14", 00:37:02 INFO - "stage_platform": "linux64-pgo", 00:37:02 INFO - "builduid": "005acac198204b229cc2500b323a4168", 00:37:02 INFO - "slavebuilddir": "test" 00:37:02 INFO - } 00:37:02 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. 00:37:02 INFO - Running post-action listener: _resource_record_post_action 00:37:02 INFO - ##### 00:37:02 INFO - ##### Running download-and-extract step. 00:37:02 INFO - ##### 00:37:02 INFO - Running pre-action listener: _resource_record_pre_action 00:37:02 INFO - Running main action method: download_and_extract 00:37:02 INFO - mkdir: /builds/slave/test/build/tests 00:37:02 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')]} 00:37:02 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 00:37:02 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 00:37:02 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 00:37:02 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 00:37:02 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 00:37:06 INFO - Downloaded 1327 bytes. 00:37:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 00:37:06 INFO - Using the following test package requirements: 00:37:06 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 00:37:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 00:37:06 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 00:37:06 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'jsshell-linux-x86_64.zip'], 00:37:06 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 00:37:06 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 00:37:06 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 00:37:06 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 00:37:06 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 00:37:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 00:37:06 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 00:37:06 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:37:06 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')]} 00:37:06 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 00:37:06 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 00:37:06 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 00:37:06 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 00:37:06 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 00:37:07 INFO - Downloaded 24237367 bytes. 00:37:07 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'] 00:37:07 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 00:37:08 INFO - Return code: 0 00:37:08 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 00:37:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:08 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 00:37:08 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 00:37:08 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 00:37:08 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 00:37:08 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 00:37:14 INFO - Downloaded 24237367 bytes. 00:37:14 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'] 00:37:14 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 00:37:15 INFO - Return code: 0 00:37:15 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')]} 00:37:15 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 00:37:15 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 00:37:15 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 00:37:15 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 00:37:15 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 00:37:16 INFO - Downloaded 10840145 bytes. 00:37:16 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'] 00:37:16 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 00:37:16 INFO - Return code: 0 00:37:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:16 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 00:37:16 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 00:37:16 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 00:37:16 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 00:37:16 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 00:37:18 INFO - Downloaded 56031681 bytes. 00:37:18 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 00:37:18 INFO - mkdir: /builds/slave/test/properties 00:37:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:37:18 INFO - Writing to file /builds/slave/test/properties/build_url 00:37:18 INFO - Contents: 00:37:18 INFO - build_url:https://queue.taskcluster.net/v1/task/LG-y1RB0TuCmMI06I5S9Fw/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 00:37:19 INFO - Running post-action listener: _resource_record_post_action 00:37:19 INFO - Running post-action listener: set_extra_try_arguments 00:37:19 INFO - ##### 00:37:19 INFO - ##### Running populate-webroot step. 00:37:19 INFO - ##### 00:37:19 INFO - Running pre-action listener: _resource_record_pre_action 00:37:19 INFO - Running main action method: populate_webroot 00:37:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:37:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:37:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:37:19 INFO - '--tppagecycles', 00:37:19 INFO - '7'], 00:37:19 INFO - 'tests': ['tsvgm']}}, 00:37:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:37:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:37:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:37:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:37:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['damp', 'tps']}, 00:37:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'tests': ['damp', 'tps']}, 00:37:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['dromaeo_dom']}, 00:37:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:37:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'other-e10s': {'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['a11yr', 00:37:19 INFO - 'ts_paint', 00:37:19 INFO - 'tpaint', 00:37:19 INFO - 'sessionrestore', 00:37:19 INFO - 'sessionrestore_no_auto_restore', 00:37:19 INFO - 'tabpaint']}, 00:37:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['tsvgx', 00:37:19 INFO - 'tsvgr_opacity', 00:37:19 INFO - 'tart', 00:37:19 INFO - 'tscrollx', 00:37:19 INFO - 'cart']}, 00:37:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:37:19 INFO - 'tsvgr_opacity', 00:37:19 INFO - 'tart', 00:37:19 INFO - 'tscrollx', 00:37:19 INFO - 'cart']}, 00:37:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'talos_options': ['--disable-e10s'], 00:37:19 INFO - 'tests': ['tp5o']}, 00:37:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'tests': ['tp5o']}, 00:37:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'talos_options': ['--disable-e10s', 00:37:19 INFO - '--xperf_path', 00:37:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:19 INFO - 'tests': ['tp5n']}, 00:37:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:37:19 INFO - 'talos_options': ['--xperf_path', 00:37:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:19 INFO - 'tests': ['tp5n']}}, 00:37:19 INFO - 'talos.zip': {'path': '', 00:37:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:37:19 INFO - Running post-action listener: _resource_record_post_action 00:37:19 INFO - ##### 00:37:19 INFO - ##### Running create-virtualenv step. 00:37:19 INFO - ##### 00:37:19 INFO - Running pre-action listener: _resource_record_pre_action 00:37:19 INFO - Running main action method: create_virtualenv 00:37:19 INFO - Creating virtualenv /builds/slave/test/build/venv 00:37:19 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 00:37:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:37:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:37:19 INFO - Using real prefix '/usr' 00:37:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:37:19 INFO - Installing distribute.............................................................................................................................................................................................done. 00:37:21 INFO - Installing pip.................done. 00:37:21 INFO - Return code: 0 00:37:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:37: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')]} 00:37:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37: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')]} 00:37:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:37:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:37:21 INFO - Using env: {'DISPLAY': ':0', 00:37:21 INFO - 'HOME': '/home/cltbld', 00:37:21 INFO - 'LANG': 'en_US.UTF-8', 00:37:21 INFO - 'LANGUAGE': 'en_US:en', 00:37:21 INFO - 'LOGNAME': 'cltbld', 00:37:21 INFO - 'MAIL': '/var/mail/cltbld', 00:37:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:21 INFO - 'MOZ_NO_REMOTE': '1', 00:37:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:21 INFO - 'NO_EM_RESTART': '1', 00:37:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:21 INFO - 'PWD': '/builds/slave/test', 00:37:21 INFO - 'SHELL': '/bin/bash', 00:37:21 INFO - 'SHLVL': '1', 00:37:21 INFO - 'TERM': 'linux', 00:37:21 INFO - 'TMOUT': '86400', 00:37:21 INFO - 'USER': 'cltbld', 00:37:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:21 INFO - '_': '/tools/buildbot/bin/python'} 00:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:22 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 00:37:22 INFO - Cleaning up... 00:37:22 INFO - Return code: 0 00:37:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:22 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:22 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 00:37:22 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 00:37:22 INFO - Using env: {'DISPLAY': ':0', 00:37:22 INFO - 'HOME': '/home/cltbld', 00:37:22 INFO - 'LANG': 'en_US.UTF-8', 00:37:22 INFO - 'LANGUAGE': 'en_US:en', 00:37:22 INFO - 'LOGNAME': 'cltbld', 00:37:22 INFO - 'MAIL': '/var/mail/cltbld', 00:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:22 INFO - 'MOZ_NO_REMOTE': '1', 00:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:22 INFO - 'NO_EM_RESTART': '1', 00:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:22 INFO - 'PWD': '/builds/slave/test', 00:37:22 INFO - 'SHELL': '/bin/bash', 00:37:22 INFO - 'SHLVL': '1', 00:37:22 INFO - 'TERM': 'linux', 00:37:22 INFO - 'TMOUT': '86400', 00:37:22 INFO - 'USER': 'cltbld', 00:37:22 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:22 INFO - '_': '/tools/buildbot/bin/python'} 00:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:22 INFO - Downloading/unpacking psutil>=0.7.1 00:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:24 INFO - Installing collected packages: psutil 00:37:24 INFO - Running setup.py install for psutil 00:37:24 INFO - building 'psutil._psutil_linux' extension 00:37:24 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 00:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 00:37:24 INFO - building 'psutil._psutil_posix' extension 00:37:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 00:37:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 00:37:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:24 INFO - Successfully installed psutil 00:37:24 INFO - Cleaning up... 00:37:24 INFO - Return code: 0 00:37:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:24 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:24 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 00:37:24 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 00:37:24 INFO - Using env: {'DISPLAY': ':0', 00:37:24 INFO - 'HOME': '/home/cltbld', 00:37:24 INFO - 'LANG': 'en_US.UTF-8', 00:37:24 INFO - 'LANGUAGE': 'en_US:en', 00:37:24 INFO - 'LOGNAME': 'cltbld', 00:37:24 INFO - 'MAIL': '/var/mail/cltbld', 00:37:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:24 INFO - 'MOZ_NO_REMOTE': '1', 00:37:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:24 INFO - 'NO_EM_RESTART': '1', 00:37:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:24 INFO - 'PWD': '/builds/slave/test', 00:37:24 INFO - 'SHELL': '/bin/bash', 00:37:24 INFO - 'SHLVL': '1', 00:37:24 INFO - 'TERM': 'linux', 00:37:24 INFO - 'TMOUT': '86400', 00:37:24 INFO - 'USER': 'cltbld', 00:37:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:24 INFO - '_': '/tools/buildbot/bin/python'} 00:37:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:37:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:37:27 INFO - Installing collected packages: mozsystemmonitor 00:37:27 INFO - Running setup.py install for mozsystemmonitor 00:37:27 INFO - Successfully installed mozsystemmonitor 00:37:27 INFO - Cleaning up... 00:37:27 INFO - Return code: 0 00:37:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:27 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:27 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 00:37:27 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 00:37:27 INFO - Using env: {'DISPLAY': ':0', 00:37:27 INFO - 'HOME': '/home/cltbld', 00:37:27 INFO - 'LANG': 'en_US.UTF-8', 00:37:27 INFO - 'LANGUAGE': 'en_US:en', 00:37:27 INFO - 'LOGNAME': 'cltbld', 00:37:27 INFO - 'MAIL': '/var/mail/cltbld', 00:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:27 INFO - 'MOZ_NO_REMOTE': '1', 00:37:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:27 INFO - 'NO_EM_RESTART': '1', 00:37:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:27 INFO - 'PWD': '/builds/slave/test', 00:37:27 INFO - 'SHELL': '/bin/bash', 00:37:27 INFO - 'SHLVL': '1', 00:37:27 INFO - 'TERM': 'linux', 00:37:27 INFO - 'TMOUT': '86400', 00:37:27 INFO - 'USER': 'cltbld', 00:37:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:27 INFO - '_': '/tools/buildbot/bin/python'} 00:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:27 INFO - Downloading/unpacking blobuploader==1.2.4 00:37:27 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 00:37:27 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 00:37:27 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 00:37:27 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 00:37:27 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 00:37:27 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 00:37:29 INFO - Downloading blobuploader-1.2.4.tar.gz 00:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:37:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:37:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:29 INFO - Downloading docopt-0.6.1.tar.gz 00:37:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:37:30 INFO - Installing collected packages: blobuploader, requests, docopt 00:37:30 INFO - Running setup.py install for blobuploader 00:37:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:37:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:37:30 INFO - Running setup.py install for requests 00:37:30 INFO - Running setup.py install for docopt 00:37:30 INFO - Successfully installed blobuploader requests docopt 00:37:30 INFO - Cleaning up... 00:37:30 INFO - Return code: 0 00:37:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37:30 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')]} 00:37:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:30 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')]} 00:37:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:30 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:30 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 00:37:30 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 00:37:30 INFO - Using env: {'DISPLAY': ':0', 00:37:30 INFO - 'HOME': '/home/cltbld', 00:37:30 INFO - 'LANG': 'en_US.UTF-8', 00:37:30 INFO - 'LANGUAGE': 'en_US:en', 00:37:30 INFO - 'LOGNAME': 'cltbld', 00:37:30 INFO - 'MAIL': '/var/mail/cltbld', 00:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:30 INFO - 'MOZ_NO_REMOTE': '1', 00:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:30 INFO - 'NO_EM_RESTART': '1', 00:37:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:30 INFO - 'PWD': '/builds/slave/test', 00:37:30 INFO - 'SHELL': '/bin/bash', 00:37:30 INFO - 'SHLVL': '1', 00:37:30 INFO - 'TERM': 'linux', 00:37:30 INFO - 'TMOUT': '86400', 00:37:30 INFO - 'USER': 'cltbld', 00:37:30 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:30 INFO - '_': '/tools/buildbot/bin/python'} 00:37:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:37:30 INFO - Running setup.py (path:/tmp/pip-bkFmd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:37:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:37:30 INFO - Running setup.py (path:/tmp/pip-KagaHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:37:31 INFO - Running setup.py (path:/tmp/pip-UmJ9Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:37:31 INFO - Running setup.py (path:/tmp/pip-b2eOkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:37:31 INFO - Running setup.py (path:/tmp/pip-HHxgvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:37:31 INFO - Running setup.py (path:/tmp/pip-cgZarZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:37:31 INFO - Running setup.py (path:/tmp/pip-Rji9gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:37:31 INFO - Running setup.py (path:/tmp/pip-JQo9Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:37:31 INFO - Running setup.py (path:/tmp/pip-Fl02KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:37:31 INFO - Running setup.py (path:/tmp/pip-qHokyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:37:31 INFO - Running setup.py (path:/tmp/pip-Hwl0Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:37:31 INFO - Running setup.py (path:/tmp/pip-I5XLy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:37:31 INFO - Running setup.py (path:/tmp/pip-IipGtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:37:31 INFO - Running setup.py (path:/tmp/pip-oAX1uY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:31 INFO - Running setup.py (path:/tmp/pip-yGk0hG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:37:31 INFO - Running setup.py (path:/tmp/pip-yfZWep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:37:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:37:32 INFO - Running setup.py (path:/tmp/pip-zofti9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:37:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:37:32 INFO - Running setup.py install for manifestparser 00:37:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozcrash 00:37:32 INFO - Running setup.py install for mozdebug 00:37:32 INFO - Running setup.py install for mozdevice 00:37:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozfile 00:37:32 INFO - Running setup.py install for mozhttpd 00:37:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozinfo 00:37:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozInstall 00:37:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:37:32 INFO - Running setup.py install for mozleak 00:37:32 INFO - Running setup.py install for mozlog 00:37:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for moznetwork 00:37:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozprocess 00:37:33 INFO - Running setup.py install for mozprofile 00:37:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozrunner 00:37:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Running setup.py install for mozscreenshot 00:37:33 INFO - Running setup.py install for moztest 00:37:33 INFO - Running setup.py install for mozversion 00:37:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:37:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:37:33 INFO - Cleaning up... 00:37:33 INFO - Return code: 0 00:37:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37: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')]} 00:37:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37: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')]} 00:37:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:33 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:33 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 00:37:33 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 00:37:33 INFO - Using env: {'DISPLAY': ':0', 00:37:33 INFO - 'HOME': '/home/cltbld', 00:37:33 INFO - 'LANG': 'en_US.UTF-8', 00:37:33 INFO - 'LANGUAGE': 'en_US:en', 00:37:33 INFO - 'LOGNAME': 'cltbld', 00:37:33 INFO - 'MAIL': '/var/mail/cltbld', 00:37:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:33 INFO - 'MOZ_NO_REMOTE': '1', 00:37:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:33 INFO - 'NO_EM_RESTART': '1', 00:37:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:33 INFO - 'PWD': '/builds/slave/test', 00:37:33 INFO - 'SHELL': '/bin/bash', 00:37:33 INFO - 'SHLVL': '1', 00:37:33 INFO - 'TERM': 'linux', 00:37:33 INFO - 'TMOUT': '86400', 00:37:33 INFO - 'USER': 'cltbld', 00:37:33 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:33 INFO - '_': '/tools/buildbot/bin/python'} 00:37:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:37:34 INFO - Running setup.py (path:/tmp/pip-JF6HGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:37:34 INFO - Running setup.py (path:/tmp/pip-QkVD4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:37:34 INFO - Running setup.py (path:/tmp/pip-paBydl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:37:34 INFO - Running setup.py (path:/tmp/pip-JMwZQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:37:34 INFO - Running setup.py (path:/tmp/pip-LEajJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:37:34 INFO - Running setup.py (path:/tmp/pip-YVsnhH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:37:34 INFO - Running setup.py (path:/tmp/pip-Arfusv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:37:34 INFO - Running setup.py (path:/tmp/pip-m1dG9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:37:34 INFO - Running setup.py (path:/tmp/pip-rLHIHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:37:34 INFO - Running setup.py (path:/tmp/pip-qweV6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:37:34 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)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:37:34 INFO - Running setup.py (path:/tmp/pip-5F5_Bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:37:34 INFO - Running setup.py (path:/tmp/pip-7FdAG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:37:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:37:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:37:34 INFO - Running setup.py (path:/tmp/pip-pf02vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:37:35 INFO - Running setup.py (path:/tmp/pip-KVc6d_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:35 INFO - Running setup.py (path:/tmp/pip-CipgOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:37:35 INFO - Running setup.py (path:/tmp/pip-2CwFdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:37:35 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)) 00:37:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:37:35 INFO - Running setup.py (path:/tmp/pip-C0NJ0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:37:35 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)) 00:37:35 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)) 00:37:35 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)) 00:37:35 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)) 00:37:35 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)) 00:37:35 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)) 00:37:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:37:35 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 00:37:35 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 00:37:35 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 00:37:35 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 00:37:35 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 00:37:35 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 00:37:37 INFO - Downloading blessings-1.6.tar.gz 00:37:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:37:37 INFO - Installing collected packages: blessings 00:37:37 INFO - Running setup.py install for blessings 00:37:37 INFO - Successfully installed blessings 00:37:37 INFO - Cleaning up... 00:37:37 INFO - Return code: 0 00:37:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:37:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:37:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:37:37 INFO - Reading from file tmpfile_stdout 00:37:37 INFO - Current package versions: 00:37:37 INFO - argparse == 1.2.1 00:37:37 INFO - blessings == 1.6 00:37:37 INFO - blobuploader == 1.2.4 00:37:37 INFO - docopt == 0.6.1 00:37:37 INFO - manifestparser == 1.1 00:37:37 INFO - mozInstall == 1.12 00:37:37 INFO - mozcrash == 0.17 00:37:37 INFO - mozdebug == 0.1 00:37:37 INFO - mozdevice == 0.48 00:37:37 INFO - mozfile == 1.2 00:37:37 INFO - mozhttpd == 0.7 00:37:37 INFO - mozinfo == 0.9 00:37:37 INFO - mozleak == 0.1 00:37:37 INFO - mozlog == 3.1 00:37:37 INFO - moznetwork == 0.27 00:37:37 INFO - mozprocess == 0.22 00:37:37 INFO - mozprofile == 0.28 00:37:37 INFO - mozrunner == 6.11 00:37:37 INFO - mozscreenshot == 0.1 00:37:37 INFO - mozsystemmonitor == 0.0 00:37:37 INFO - moztest == 0.7 00:37:37 INFO - mozversion == 1.4 00:37:37 INFO - psutil == 3.1.1 00:37:37 INFO - requests == 1.2.3 00:37:37 INFO - wsgiref == 0.1.2 00:37:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:37:37 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')]} 00:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:37 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')]} 00:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:37 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:37 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 00:37:37 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 00:37:37 INFO - Using env: {'DISPLAY': ':0', 00:37:37 INFO - 'HOME': '/home/cltbld', 00:37:37 INFO - 'LANG': 'en_US.UTF-8', 00:37:37 INFO - 'LANGUAGE': 'en_US:en', 00:37:37 INFO - 'LOGNAME': 'cltbld', 00:37:37 INFO - 'MAIL': '/var/mail/cltbld', 00:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:37 INFO - 'MOZ_NO_REMOTE': '1', 00:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:37 INFO - 'NO_EM_RESTART': '1', 00:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:37 INFO - 'PWD': '/builds/slave/test', 00:37:37 INFO - 'SHELL': '/bin/bash', 00:37:37 INFO - 'SHLVL': '1', 00:37:37 INFO - 'TERM': 'linux', 00:37:37 INFO - 'TMOUT': '86400', 00:37:37 INFO - 'USER': 'cltbld', 00:37:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:37 INFO - '_': '/tools/buildbot/bin/python'} 00:37:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 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)) 00:37:37 INFO - Cleaning up... 00:37:37 INFO - Return code: 0 00:37:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:37:37 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')]} 00:37:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:37 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')]} 00:37:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:37 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:37 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 00:37:37 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 00:37:37 INFO - Using env: {'DISPLAY': ':0', 00:37:37 INFO - 'HOME': '/home/cltbld', 00:37:37 INFO - 'LANG': 'en_US.UTF-8', 00:37:37 INFO - 'LANGUAGE': 'en_US:en', 00:37:37 INFO - 'LOGNAME': 'cltbld', 00:37:37 INFO - 'MAIL': '/var/mail/cltbld', 00:37:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:37 INFO - 'MOZ_NO_REMOTE': '1', 00:37:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:37 INFO - 'NO_EM_RESTART': '1', 00:37:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:37 INFO - 'PWD': '/builds/slave/test', 00:37:37 INFO - 'SHELL': '/bin/bash', 00:37:37 INFO - 'SHLVL': '1', 00:37:37 INFO - 'TERM': 'linux', 00:37:37 INFO - 'TMOUT': '86400', 00:37:37 INFO - 'USER': 'cltbld', 00:37:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:37 INFO - '_': '/tools/buildbot/bin/python'} 00:37:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:38 INFO - Downloading/unpacking jsonschema 00:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:37:39 INFO - Downloading/unpacking functools32 (from jsonschema) 00:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:40 INFO - Downloading functools32-3.2.3-2.tar.gz 00:37:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:37:40 INFO - warning: no files found matching '*.txt' 00:37:40 INFO - no previously-included directories found matching 'build' 00:37:40 INFO - no previously-included directories found matching 'dist' 00:37:40 INFO - no previously-included directories found matching '.git*' 00:37:40 INFO - Installing collected packages: jsonschema, functools32 00:37:40 INFO - Running setup.py install for functools32 00:37:40 INFO - warning: no files found matching '*.txt' 00:37:40 INFO - no previously-included directories found matching 'build' 00:37:40 INFO - no previously-included directories found matching 'dist' 00:37:40 INFO - no previously-included directories found matching '.git*' 00:37:40 INFO - Successfully installed jsonschema functools32 00:37:40 INFO - Cleaning up... 00:37:40 INFO - Return code: 0 00:37:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:37:40 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')]} 00:37:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:40 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')]} 00:37:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:40 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 0x7f63d2c59f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11808a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x124c7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', '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 00:37:40 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 00:37:40 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 00:37:40 INFO - Using env: {'DISPLAY': ':0', 00:37:40 INFO - 'HOME': '/home/cltbld', 00:37:40 INFO - 'LANG': 'en_US.UTF-8', 00:37:40 INFO - 'LANGUAGE': 'en_US:en', 00:37:40 INFO - 'LOGNAME': 'cltbld', 00:37:40 INFO - 'MAIL': '/var/mail/cltbld', 00:37:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:40 INFO - 'MOZ_NO_REMOTE': '1', 00:37:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:40 INFO - 'NO_EM_RESTART': '1', 00:37:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:40 INFO - 'PWD': '/builds/slave/test', 00:37:40 INFO - 'SHELL': '/bin/bash', 00:37:40 INFO - 'SHLVL': '1', 00:37:40 INFO - 'TERM': 'linux', 00:37:40 INFO - 'TMOUT': '86400', 00:37:40 INFO - 'USER': 'cltbld', 00:37:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:40 INFO - '_': '/tools/buildbot/bin/python'} 00:37:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:40 INFO - Downloading/unpacking flake8 00:37:40 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 00:37:40 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 00:37:40 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 00:37:40 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 00:37:40 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 00:37:40 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 00:37:42 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:37:42 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:37:42 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:42 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 00:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:37:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:37:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:37:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:37:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:37:43 INFO - no previously-included directories found matching 'docs/_build' 00:37:43 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:37:43 INFO - Running setup.py install for pep8 00:37:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:37:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:37:43 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:37:43 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:37:43 INFO - no previously-included directories found matching 'docs/_build' 00:37:43 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:37:43 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:37:43 INFO - Cleaning up... 00:37:43 INFO - Return code: 0 00:37:43 INFO - Running post-action listener: _resource_record_post_action 00:37:43 INFO - Running post-action listener: _start_resource_monitoring 00:37:43 INFO - Starting resource monitoring. 00:37:43 INFO - ##### 00:37:43 INFO - ##### Running install step. 00:37:43 INFO - ##### 00:37:43 INFO - Running pre-action listener: _resource_record_pre_action 00:37:43 INFO - Running main action method: install 00:37:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:37:43 INFO - Reading from file tmpfile_stdout 00:37:43 INFO - Detecting whether we're running mozinstall >=1.0... 00:37:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:37:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:37:43 INFO - Reading from file tmpfile_stdout 00:37:43 INFO - Output received: 00:37:43 INFO - Usage: mozinstall [options] installer 00:37:43 INFO - Options: 00:37:43 INFO - -h, --help show this help message and exit 00:37:43 INFO - -d DEST, --destination=DEST 00:37:43 INFO - Directory to install application into. [default: 00:37:43 INFO - "/builds/slave/test"] 00:37:43 INFO - --app=APP Application being installed. [default: firefox] 00:37:43 INFO - mkdir: /builds/slave/test/build/application 00:37:43 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'] 00:37:43 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 00:37:57 INFO - Reading from file tmpfile_stdout 00:37:57 INFO - Output received: 00:37:57 INFO - /builds/slave/test/build/application/firefox/firefox 00:37:57 INFO - Running post-action listener: _resource_record_post_action 00:37:57 INFO - ##### 00:37:57 INFO - ##### Running run-tests step. 00:37:57 INFO - ##### 00:37:57 INFO - Running pre-action listener: _resource_record_pre_action 00:37:57 INFO - Running main action method: run_tests 00:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:37:57 INFO - Python 2.7.3 00:37:57 INFO - Return code: 0 00:37:57 INFO - grabbing minidump binary from tooltool 00:37: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')]} 00:37:57 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 0x12db640>, '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 0x12dc540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12dc9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:37:57 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 00:37:57 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 00:37:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:37:57 INFO - Return code: 0 00:37:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:37:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:37:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:37:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:37:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:37:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:37:58 INFO - Return code: 0 00:37:58 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-002', '--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 00:37:58 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-002 --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 00:37:58 INFO - Using env: {'DISPLAY': ':0', 00:37:58 INFO - 'HOME': '/home/cltbld', 00:37:58 INFO - 'LANG': 'en_US.UTF-8', 00:37:58 INFO - 'LANGUAGE': 'en_US:en', 00:37:58 INFO - 'LOGNAME': 'cltbld', 00:37:58 INFO - 'MAIL': '/var/mail/cltbld', 00:37:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:37:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:58 INFO - 'MOZ_NO_REMOTE': '1', 00:37:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:37:58 INFO - 'NO_EM_RESTART': '1', 00:37:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:58 INFO - 'PWD': '/builds/slave/test', 00:37:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:37:58 INFO - 'SHELL': '/bin/bash', 00:37:58 INFO - 'SHLVL': '1', 00:37:58 INFO - 'TERM': 'linux', 00:37:58 INFO - 'TMOUT': '86400', 00:37:58 INFO - 'USER': 'cltbld', 00:37:58 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160', 00:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:58 INFO - '_': '/tools/buildbot/bin/python'} 00:37:58 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-002', '--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 00:37:58 INFO - mozversion application_buildid: 20160706215822 00:37:58 INFO - mozversion application_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 00:37:58 INFO - mozversion application_display_name: Firefox 00:37:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:37:58 INFO - mozversion application_name: Firefox 00:37:58 INFO - mozversion application_remotingname: firefox 00:37:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 00:37:58 INFO - mozversion application_vendor: Mozilla 00:37:58 INFO - mozversion application_version: 48.0 00:37:58 INFO - mozversion platform_buildid: 20160706215822 00:37:58 INFO - mozversion platform_changeset: d142c49033c015f67272562b37dbe2912cfc7f14 00:37:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 00:37:58 INFO - mozversion platform_version: 48.0 00:37:58 INFO - using testdate: 1467877078 00:37:58 INFO - actual date: 1467877078 00:37:58 INFO - starting webserver on 'localhost:55342' 00:37:58 INFO - SUITE-START | Running 2 tests 00:37:58 INFO - TEST-START | dromaeo_css 00:37:58 INFO - operating with platform_type : linux_ 00:37:58 INFO - Initialising browser for dromaeo_css test... 00:37:58 INFO - TEST-INFO | started process 4247 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkbVf59/profile http://localhost:55342/getInfo.html) 00:38:01 INFO - PROCESS | 4247 | 00:38:01 INFO - PROCESS | 4247 | (process:4323): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:38:02 INFO - PROCESS | 4247 | __metrics Screen width/height:1600/1200 00:38:02 INFO - PROCESS | 4247 | colorDepth:24 00:38:02 INFO - PROCESS | 4247 | Browser inner width/height: 1024/697 00:38:02 INFO - PROCESS | 4247 | __metrics 00:38:03 ERROR - PROCESS | 4247 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:38:03 INFO - TEST-INFO | 4247: exit 0 00:38:03 INFO - Browser initialized. 00:38:03 INFO - Running cycle 1/1 for dromaeo_css test... 00:38:03 INFO - TEST-INFO | started process 4374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkbVf59/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:05 INFO - PROCESS | 4374 | 00:38:05 INFO - PROCESS | 4374 | (process:4443): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:38:15 INFO - PROCESS | 4374 | RSS: Main: 150716416 00:38:15 INFO - PROCESS | 4374 | 00:39:05 INFO - PROCESS | 4374 | 1467877145322 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] 00:41:12 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55342/tests/dromaeo/cssquery-ext.html) 00:41:13 INFO - PROCESS | 4374 | RSS: Main: 153559040 00:41:13 INFO - PROCESS | 4374 | 00:44:15 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-ext.html (next: http://localhost:55342/tests/dromaeo/cssquery-jquery.html) 00:44:15 INFO - PROCESS | 4374 | RSS: Main: 152133632 00:44:15 INFO - PROCESS | 4374 | 00:47:17 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55342/tests/dromaeo/cssquery-mootools.html) 00:47:18 INFO - PROCESS | 4374 | RSS: Main: 150700032 00:47:18 INFO - PROCESS | 4374 | 00:50:19 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55342/tests/dromaeo/cssquery-prototype.html) 00:50:20 INFO - PROCESS | 4374 | RSS: Main: 152670208 00:50:20 INFO - PROCESS | 4374 | 00:53:22 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55342/tests/dromaeo/cssquery-yui.html) 00:53:23 INFO - PROCESS | 4374 | RSS: Main: 151855104 00:53:23 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | Cycle 1(1): loaded http://localhost:55342/tests/dromaeo/cssquery-yui.html (next: http://localhost:55342/tests/dromaeo/cssquery-dojo.html) 00:56:25 INFO - PROCESS | 4374 | RSS: Main: 153800704 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | __start_tp_report 00:56:25 INFO - PROCESS | 4374 | _x_x_mozilla_page_load 00:56:25 INFO - PROCESS | 4374 | _x_x_mozilla_page_load_details 00:56:25 INFO - PROCESS | 4374 | |i|pagename|runs| 00:56:25 INFO - PROCESS | 4374 | |0;dojo.html;3263.820489873057;3314.419976504111;3325.0357396355057;3339.465685490322;3348.0458069450196;5464.207689884965;5476.78092876285;5501.312335958005;5530.834074977747;5531.91702124468;5441.537469315103;5473.2063850741615;5479.4520547945185;5498.5876059295515;5503.11950087986;4989.75051247438;5010.348654674887;5047.2176812593925;5063.721495317756;5066.1387564114;4939.654224204289;4940.5306495883015;4992.775325110379;5002.399712034561;5088.211327244283;5027.673201241926;5039.420466646346;5054.924176137342;5061.848144555651;5062.759623892133;5010.849674509753;5020.171671674169;5026.79892804291;5031.270465782478;5053.74731263439;4891.951080489185;4899.657024008321;4935.5804756595735;4967.801287948478;4969.13040217964;5231.790728370861;5234.1887007513515;5245.134552798783;5264.42091369949;5303.045451818671;5694.088945768657;5713.971430142864;5719.628224165416;5738.167965645;5756.65460072397;5768.278965129359;5785.27684039495;5828.737706803204;5867.354590994987;5867.501262392701;5482.862928426782;5484.012877682016;5488.313960754906;5489.066858634042;5490.945090549083;5911.527077833849;5961.821145365646;5975.910361344583;5978;5986.940130598726;5661.235733176051;5756.5682573807135;5804.796832110856;5821.039528477839;5842.182094506772;5808.361080281165;5811.88376232473;5813.680247586423;5816.738246778905;5821.970890145607;5805.94194058054;5811.186433899257;5813.709314534256;5814.476697097197;5818.44724751148;5849.151872978395;5908.940910590925;5911.793087241926;5933.169356290123;5943.70281485924;4498.50516443191;4501.437320334958;4527.049319642846;4530.88672783183;4558.954410455853;3933.3116704576582;4002.3396139637216;4059.715819892579;4086.366613174963;4093.8771836844944;5430.864228394322;5559.138333558305;5683.062294721407;5683.147527870852;5731.168980497804;5823.970880145572;5837.211976383219;5852.385499522489;5853.765849366063;5883;5539.2522009529;5603.327600687943;5637.577181711388;5643.1535269709875;5648.85877853057;4682.85951421451;4787.712737235707;4842.104210720958;4872.731999739977;4873.19592267279;6161.784337548164;6197.380261973857;6199.535034872402;6210.378962103753;6220.813375598739;5760.222369979999;5912.467877890925;5917.437843404869;5929.140274660236;5944.5838791284195;6049.062395328731;6125;6127.250613123855;6130.948521379913;6142.754289828356;5710.971445142914;5764.221830052889;5781.190633311256;5784.913226301524;5789.91315130265;5684.118961560965;5828.242328497268;5837.912431313619;5842.065269556851;5854.121881717776;5689.800856969986;5708.315002199763;5709.65742055478;5729;5760.654360738369;5673;5695.202671625892;5696.743646535833;5703.258576385043;5724.656520608777;5541.307336582927;5559.082751345983;5570.498655121059;5595.216669666332;5615.634983726045;5752.827415177551;5776.537876969748;5781.161731548986;5786.652800831964;5792.623479473821;5622.522085622604;5673.205751194919;5680.204771331934;5685.658860468385;5687.630304030225 00:56:25 INFO - PROCESS | 4374 | |1;ext.html;665.733706517393;672.7981605518344;678.0845858091577;681.9590824550526;682.522234435895;39957.20085598286;41261.17477650445;41337.75986720396;41421.58578414215;41460.17079658409;44723.55276447243;45431.54568454315;45506.54493455064;45543.544564554424;45559.77220113895;8843.425177363482;9101.180893719564;9101.95449022754;9108.45349279042;9115.908840911605;9056;9182.816343673123;9200.263978881707;9215.861762073575;9219;9241.306901982345;9267.814643707121;9311;9323.30075244356;9342.486163261017;9143.862842057375;9183.448993060438;9188.586513606904;9213.262938964866;9241.445513269226;9154.588043538057;9252.907470925273;9253.259739220846;9279.953600232024;9289.767755806091;43391;44248.55751442476;44289.77855110704;44297.11405771899;44383;3690.6862916652117;3896.1038961038835;4203.831846726158;4210.136921930997;4532.4334458192725;33463.498047529305;33543.49684754731;33848.49227261593;33868.83065584656;33981.98054058382;4238.851640192609;4270.701050926436;4279.144171165748;4328.394024836525;4458.242098843204;333831;334694;336119;337221;337553;65192.67403663046;65223.34776652173;65597;65657;65732.34267657262;72598;73429.26570734331;73454.6327268371;74109;74189.6290518544;18786.90606546986;18949.810501894804;19057.90471047636;19068.33260835864;19094;14382.424703011762;14421.278936053155;14478.203698796668;14503.274836258144;14591.708165836624;21685.349439516838;21701.67447488289;21783.455413614785;21922;21944.670829937564;7585.658645360972;7798.376129909594;8052.959735201403;8251.546164960864;8298;1201.9519219231308;1223.5900973174087;1239.913206075566;1312.3635037007043;1325.5758157389544;33571.496427553604;34200.31599368049;34276.82861585726;34635.13412164716;34717.82641086778;1217.3243849663345;1232.3160645841465;1284.0082607524446;1329.0497294434526;1331.633800704814;17698.96521158871;17899.73150402745;18017.639647207245;18026.909865450853;18120.36578719765;489643;498845;595003;602001;791945;64451;65066.34933650697;65121.67439162774;65292.34707652958;65454;1523.7333466643292;1559.5945054285967;1577.1010524001438;1589.435750308647;1594.8628837357996;33958.66041339555;34635;34647.4802877952;35026.299474010884;35058.298834022666;56221.71889140528;57227;57262;57313;57379.42620573741;461292;465174;466425;467788;470422;31270.53094203634;31474.37051258916;31716.524252135776;31938.36123277475;31968.200794980312;51521;51710.482895170564;51801;52898;53256.2011569819;42582.787086064374;43224.35163472487;43766.12467750691;43816.78091609522;45301;42381.57618423776;42546.361804572334;43057.13885722205;43315.56684433115;43648;44874;44897.32654010127;45455.54544454513;46028.539714602426;46329.53670463252;37142;37306;37452.812735936146;37688.62311376961;38189.618103818604;29172.56241156342;30304.393912122076;30384.696153038185;30748.538771917993;30918 00:56:25 INFO - PROCESS | 4374 | |2;jquery.html;430.55222568528734;431.4649834205584;444.4355867346941;445.3395219032821;455.79944824277294;18517;18738.62522749546;19259.903700481496;20850.270240541584;20939.267125650604;18389.172487238073;19042.619147617075;19353.129109190086;19395.418137455865;19458.416247512563;5248.790048398059;5355;5392.352917649888;5394.487523685244;5421.620486565942;5326.973365133169;5383.380911195204;5422.4306447823;5442.210879422481;5790.594658373915;5759.625624334405;5774.3936886626925;5783.016887129177;5800.53595712342;5808.709564521778;5642.153676948449;5757.539396848242;5792.044312688401;5841.474267315941;5903.527717782567;5745.425457454263;5764.33710123337;5774.48029677331;5777.7977770777825;5779.797707080274;14085.71828563423;14682.853171468256;14683.119012859263;14690.853091469162;14692.853071469362;2532.227670560478;2535.378832186108;2553.323369307135;2571.048711976562;2920.8977685780897;10114.949425252827;10404.791904161875;10714.785704285949;10803.4058126803;10806.675799726021;1809.267246765049;1845.1420089658238;1908.0745838268429;1947.9902600487048;1970.3103913630114;76415.23584764192;77303;78070.60964695197;78448.21551784466;78486.19297396294;11452.484638191301;11775.705607359885;11783.175177737647;11813;11832.645020649394;16208.675826483404;16296.83703162977;16305.918470407572;16325.265363058454;16353.672926541403;7761.68953241864;8145.796355091052;8174.509529428254;8325.708600198965;8336;7795.961020194863;7860.174681658458;7908.762737117896;7976.680932762624;8272.090070092285;4861.951380486221;4978.701277923336;4988.152014157529;5035.697858128524;5045.949540504622;2096.528281136732;2147.302126808793;2155.8706477611395;2164.426426996847;2173.739151301854;1030.4178139351243;1101.0145919402091;1119.9328040317607;1153.2125205930774;1182.8225766134976;19077.523061923563;19104.904475477535;19462.610747784965;19468.70796938047;19797;1127.7293449572044;1134.427114307286;1175.26545908807;1187.1749134351542;1211.6425654431964;10853.51159197838;10892.455377231265;11441.713957151138;11568.710782230512;11882.702932426759;529113;533571;537154;553210;558603;94686;97291.51354243183;98825;100126;100404.4979775111;1152.0668258710305;1161.2393882007298;1170.5610396101463;1172.6482055383522;1185.2947496239724;18173.45479635613;18187.363442279457;18319;18385.90807045956;18503.722444163617;40626.39060414037;41072.79463602663;42370.36444453274;42556;42563;60001.39998599958;62170.37829621646;62187.37812621997;62421;62643.06035409381;9189.448633082036;9302.209312208539;9306.441613503212;9349.813003739751;9527.09492598202;12881.742365152457;13550.728985420434;13897.513587024405;13939.233342166279;14070.718585628025;11737.35444550558;11912.10659200546;11953.282803031845;12011.219270747373;12118.333491657691;11790.174687772116;12074.75850483003;12269.69325766863;12332.32172230536;12429.502819887104;11956.34240116767;11995.280283183038;12001;12560.183588066746;12697.746045079231;9205.631774728936;9287.396319239228;9326.347155699308;9338.439693618133;9434.150926416656;9747;12443.75112497763;12545.372731363213;12623.621291361274;12680.23918564889 00:56:25 INFO - PROCESS | 4374 | |3;mootools.html;1542.467848592236;1552.371289627701;1783.652187823374;1897.506648271449;1915.224334144672;7503.962480187592;8168.264856162944;8186.631601577928;8321.54231517267;8381.497110173386;8217.958910205441;8244.958775206116;8326.708565200219;8449.873251901212;8470.068292487822;2353.141103497224;2369.526094781042;2379.7382287948312;2386.2364043506086;2388.7850093491584;2377.524495100978;2423.587990041697;2423.8182136339756;2432.5499782540196;2442.4016116051503;2365.881705914706;2386.606209975352;2393.018862266471;2395.9880200598973;2404.2426635609813;2347.6478528220905;2381.57131716291;2390.8804559771943;2395.4490467192645;2402.447437089462;2402.2913240593894;2434.7443518430487;2447.070113356931;2448.5592593333195;2449.742777008424;8564.528950907697;8614.827703445895;8626.870596941051;8631.05058443577;8672.479651220883;5181.093308670967;5245.606579506552;5264.578833693296;5286.471352864722;5288.9735551322;3147.4334619768433;3202.2794871153806;3230.9030729078167;3350.983245083759;3362.9831850840587;1066.7305905971868;1070.1064611049783;1087.1357270969597;1093.792179485895;1097.9011888930036;10917.181211409097;11111.611093611686;11134.944325278322;11145.832812507819;11166.218364714474;4564.543545645409;4567.771611419415;4594.517575654575;4610.515895830957;4654.2785868190485;9863.161631261422;9898.257630677585;9907.554160062815;9956.253281003954;9961.203103751683;5232.73836308183;5265.605079619044;5308.867278318073;5325.840224793263;5336.252924590561;4685.531446855355;4757.833475828329;4790.520947905182;4812.205986012339;4852.490488498727;3957.485526881487;3988.8404463821703;3992.760434373889;4094.0379010932406;4125.566815484391;1167.9240849344765;1189.1319336884123;1189.9583514576948;1196.485511230162;1214.36245970866;929.5723966975268;950.9904900950902;1013.5033833421718;1056.8943105689523;1076.8761592416815;6050.6369617823075;6144.5084393248435;6173.043178307369;6176.8764624707255;6187.783427580103;494.3079688436218;503.93700787401576;516.8268630008914;521.5202014146994;521.8460554136539;4326.17802617508;4330.696851220384;4341.7829108545075;4343.717658352197;4347.500037495728;10074.395536267848;10274.075333220046;10450.529726162342;10460.843087353696;10495.160387169008;9696.806063878683;10298;10312.071913527818;10340.27618066728;10360.326578772356;7690.538567685845;7714.72998445063;7737.419693523008;7759.728409505753;7776.416768742367;5638.718064096696;5870.530357571299;5925.674087925033;5939.376365481735;5998.370171131968;9021.503817290111;9051.547422628973;9086.363954523384;9096.454212747256;9210.309226808151;9068.093190681144;9107.681231156877;9125.680601178927;9325.160735533835;9329.253659707072;7242.927570724225;7253.637318134178;7411.0736157980255;7412.888806667796;7436.888446673413;7927.603619819101;7940.761777146695;7955.0851652060755;7983.20167983197;8009.639566219651;7045.577265364094;7090.929090709027;7141.285871412817;7169.318914703304;7182.712691492491;6814.795556133324;6866.485013624098;6872.037914691847;6873.347032031949;7058.470614703815;6584.308647591934;6728;6745.763898263537;6761.391474767294;6816.0457535946;5203.921941170961;5238.528532432099;5242.318498595311;5253.50091741284;5333.06671332523;5000.449950505515;5145.974270128625;5151.253068305;5164.535191832753;5217.373915130209 00:56:25 INFO - PROCESS | 4374 | |4;prototype.html;354.10588264631804;357.61020487668446;363.21545461802503;372.7409450431951;372.8583138407405;6447.258565264996;6448.935510644892;6453.741850325987;6479.481641468683;6609.867802643957;6499.317571654968;6544.214694236698;6568.244651865037;6577.638229897354;6585.736570537185;4932.062908047477;4941.975290123544;4947.282644016615;4948.505149485059;4951.603871690274;4938.3580134582635;4945.455999840033;4953.207486802113;4970.676906001117;4974.751262436882;4917.21324588066;4920.68015578988;4922;4932.556069953704;4933.679310844784;4688.976555117202;4921.680090794105;4923.18767403378;4923.876903077452;4925.26121081837;4257.106007738379;4267.146570685844;4277.914441711148;4278.187144442546;4283.657307415399;6224.3464436234;6245.843853903643;6246.87506249877;6261.123442718023;6266.592671476339;5688.203651488795;5693.857653558653;5698.458646428583;5707.429257074301;5707.971460142714;6775.864482710318;6784.0841486399195;6788.72845086196;6793.898091528631;6794;4603.746793926366;4776.402949631296;4777.092352453023;4781.163296423112;4783.378160839104;7113.715451381939;7178.5692858428665;7200.351968322876;7206.1352637683285;7220.350168484809;4848.660593758403;4871.805127794849;4873.805047798049;4874.19575770001;4891.1685013547785;4939.629527785431;4944.307796908363;4945.590506705572;4948.084604348135;4948.975255123702;5715.399883012224;5722.456366645162;5731.340895797037;5732.484076433141;5733.684647344436;6667.566608170453;6901.930980690229;6908.274631163756;6930.237673855871;6937.514373993873;1704.7357659562788;1719.8710096742793;1726.507945235602;1728.0668439043027;1730.6625208084554;1128.701992708392;1136.4147464056018;1139.5840518210794;1153.1697178031804;1157.3171828621155;6677.23211830636;6821.420179284816;6829.180498340231;6836.829079273058;6855.280195579492;7206.56760594366;7209.927900721031;7230.060092187982;7241;7241.42068634508;6803.455723542104;6813.420859226922;6822.283660215705;6829.760958366533;6838.111045564145;3840.1743625120735;3858.5369755629504;3867.497225360685;3870.322693528621;3876.6317199865966;7374.3363097320425;7514.887276690854;7515.774526764206;7516.849663006709;7663.578503182379;7363.374113200331;7369.705211791468;7375.778726638209;7391.6673749681395;7397.704091836374;7638.045244344457;7639.579823109671;7646.426518011061;7653.655585498666;7655.272749088939;6962;7191.7842464726145;7192.712291508281;7204.3155900189395;7213.567185968858;7082.929170708227;7112.857742845217;7117.644117793986;7126.465515086285;7134.464915131282;7513.1359893612935;7569.621518924142;7572.129205141259;7592.772216833504;7637.770866874002;4803.255495398219;4834.468208497133;4835.758212089311;4836.081144582518;4838.806447742191;7016.19313778922;7131.500794944512;7134.357907788324;7149.571025738473;7161.677724502514;6929.68816403253;6957.060796792368;6962.408195303456;6968.268331825086;6968.860622787617;6874.2094659112845;6936.271691472322;6937.618430986344;6942.340477654615;6957.234704182637;6828.522003459909;6829.453643708392;6839.2476827547935;6842.726290948306;6847.897281540881;6856.211535673262;6931.757388491378;6941.930580694128;6967.198772141269;6985.336393042653;6699;6811.591304521745;6847.863042739018;6851.143607049119;6877.931220687729 00:56:25 INFO - PROCESS | 4374 | |5;yui.html;852.9104444033372;858.8574623136708;868.0885070675793;914.8290188558645;933.0436302789644;14396.208208548525;15839.841601583981;16035.118068506228;16058.036517808925;16076.678466430694;14804.185769782658;14847.92576037121;14909.32908019139;14917.85082149181;14954.775678364833;892.370878530636;904.6110172625769;906.0576999920075;906.6282824042144;908.0646933658343;890.692711014699;893.5219657483248;895.6372669069037;897.4525539420948;899.9145081217307;941.3410612571193;943.5942544705774;945.5272363818091;947.2989987409302;965.3725078698832;941.5715849288557;941.7174847545778;941.7833898203384;942.3309450290268;965.9130678238957;688.3976520544524;691.7682576336933;698.1935864077;701.0990876723386;713.6538778692382;14336.35486403104;14343.354549045318;14370.49703260381;14376.496822611158;14376.712465750627;14332.57002289933;14500.854991450162;14501.129932203996;14509.782353264709;14513.854861451357;11731.65813710384;11753.647390578211;11840.526378944833;11925.940370298093;12107.515699372014;3770.4344348347695;3925.2738243425056;3957.8416863325433;3988.660963818079;4036.233115708006;57193.71403142999;57253.14120288199;57307.713461432846;57416.425835741524;58145.8370832581;11081.889181108247;11087.445627718744;11277.379744114152;11357.37534435614;11367.715807104889;20441.48896277605;20595.176192952415;20636;20680.379588612366;20707;8361.665533378718;8448.32413406926;8501.234888860032;8543.530105844115;8937.419067760704;4628.236341003697;4633.189191891405;4633.258678611406;4672.345871577982;4757.405324334458;3480.338735640271;3533.699635531009;3535.9469607955903;3535.9469607955903;3561.6972557332915;601.425638515217;622.0327390907092;626.5864529410567;628.214731585518;629.0438533429253;666.2038863558098;754.5698951597647;758.4577027425307;814.8958161690942;819.0867183090811;9490;9947.80104397908;10013.799724005625;10030.197584193247;10085.798284034277;695.5861262548775;746.7834328044806;784.6625950841193;809.2797410304834;809.7692157735017;4308.482982042112;4406.052698669801;4513.593776560126;4523.683342166082;4558.749268790249;66539.66730166318;66857;67840;67856;72127;53637.46362536325;53858;54409;57069.714651426475;59592.10611840826;53196.46803531915;53257.93484130296;53562;53980.46019539833;55385.72307138438;9661.9033809661;9684.70945871625;9733.805323893625;9755.414675119515;9769.31614786958;37780;37990.24019519649;38257.80871095627;38464.80767596256;39105.2178956425;44755;45158.54841451543;49236;50506.74746626243;50796.74601626968;12768.553100641433;13049.543265985645;13109.60671179866;13162.14446061003;13484.932575337061;13630.967459927433;13956.441742330193;14032.649183770487;14342.282885855457;14551.636209094857;12834.55079072228;12894.226346419246;13015.219086854819;13023.153495022792;13326;11942.582009629621;12413.44139513742;12911.806322905351;13028.478860845838;13990.790138148139;12758.915492183269;12976.416061277076;13089.280089595164;13874.722505549631;14441.927790360982;10841.945790271313;10995.780084398428;11019.228653994143;11124.110071194447;11206;10324.328918620266;10563.20775941792;10588.682339529827;10645.787084258427;10648.307859989076 00:56:25 INFO - PROCESS | 4374 | __end_tp_report 00:56:25 INFO - PROCESS | 4374 | __start_cc_report 00:56:25 INFO - PROCESS | 4374 | _x_x_mozilla_cycle_collect,346 00:56:25 INFO - PROCESS | 4374 | __end_cc_report 00:56:25 INFO - PROCESS | 4374 | __startTimestamp1467878185884__endTimestamp 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | ------- Summary: start ------- 00:56:25 INFO - PROCESS | 4374 | Number of tests: 6 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#0] dojo.html Cycles:165 Average:5441.82 Median:5683.06 stddev:602.36 (10.6%) stddev-sans-first:579.46 00:56:25 INFO - PROCESS | 4374 | Values: 3263.8 3314.4 3325.0 3339.5 3348.0 5464.2 5476.8 5501.3 5530.8 5531.9 5441.5 5473.2 5479.5 5498.6 5503.1 4989.8 5010.3 5047.2 5063.7 5066.1 4939.7 4940.5 4992.8 5002.4 5088.2 5027.7 5039.4 5054.9 5061.8 5062.8 5010.8 5020.2 5026.8 5031.3 5053.7 4892.0 4899.7 4935.6 4967.8 4969.1 5231.8 5234.2 5245.1 5264.4 5303.0 5694.1 5714.0 5719.6 5738.2 5756.7 5768.3 5785.3 5828.7 5867.4 5867.5 5482.9 5484.0 5488.3 5489.1 5490.9 5911.5 5961.8 5975.9 5978.0 5986.9 5661.2 5756.6 5804.8 5821.0 5842.2 5808.4 5811.9 5813.7 5816.7 5822.0 5805.9 5811.2 5813.7 5814.5 5818.4 5849.2 5908.9 5911.8 5933.2 5943.7 4498.5 4501.4 4527.0 4530.9 4559.0 3933.3 4002.3 4059.7 4086.4 4093.9 5430.9 5559.1 5683.1 5683.1 5731.2 5824.0 5837.2 5852.4 5853.8 5883.0 5539.3 5603.3 5637.6 5643.2 5648.9 4682.9 4787.7 4842.1 4872.7 4873.2 6161.8 6197.4 6199.5 6210.4 6220.8 5760.2 5912.5 5917.4 5929.1 5944.6 6049.1 6125.0 6127.3 6130.9 6142.8 5711.0 5764.2 5781.2 5784.9 5789.9 5684.1 5828.2 5837.9 5842.1 5854.1 5689.8 5708.3 5709.7 5729.0 5760.7 5673.0 5695.2 5696.7 5703.3 5724.7 5541.3 5559.1 5570.5 5595.2 5615.6 5752.8 5776.5 5781.2 5786.7 5792.6 5622.5 5673.2 5680.2 5685.7 5687.6 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#1] ext.html Cycles:180 Average:64345.81 Median:43707.06 stddev:128133.44 (293.2%) stddev-sans-first:128403.68 00:56:25 INFO - PROCESS | 4374 | Values: 665.7 672.8 678.1 682.0 682.5 39957.2 41261.2 41337.8 41421.6 41460.2 44723.6 45431.5 45506.5 45543.5 45559.8 8843.4 9101.2 9102.0 9108.5 9115.9 9056.0 9182.8 9200.3 9215.9 9219.0 9241.3 9267.8 9311.0 9323.3 9342.5 9143.9 9183.4 9188.6 9213.3 9241.4 9154.6 9252.9 9253.3 9280.0 9289.8 43391.0 44248.6 44289.8 44297.1 44383.0 3690.7 3896.1 4203.8 4210.1 4532.4 33463.5 33543.5 33848.5 33868.8 33982.0 4238.9 4270.7 4279.1 4328.4 4458.2 333831.0 334694.0 336119.0 337221.0 337553.0 65192.7 65223.3 65597.0 65657.0 65732.3 72598.0 73429.3 73454.6 74109.0 74189.6 18786.9 18949.8 19057.9 19068.3 19094.0 14382.4 14421.3 14478.2 14503.3 14591.7 21685.3 21701.7 21783.5 21922.0 21944.7 7585.7 7798.4 8053.0 8251.5 8298.0 1202.0 1223.6 1239.9 1312.4 1325.6 33571.5 34200.3 34276.8 34635.1 34717.8 1217.3 1232.3 1284.0 1329.0 1331.6 17699.0 17899.7 18017.6 18026.9 18120.4 489643.0 498845.0 595003.0 602001.0 791945.0 64451.0 65066.3 65121.7 65292.3 65454.0 1523.7 1559.6 1577.1 1589.4 1594.9 33958.7 34635.0 34647.5 35026.3 35058.3 56221.7 57227.0 57262.0 57313.0 57379.4 461292.0 465174.0 466425.0 467788.0 470422.0 31270.5 31474.4 31716.5 31938.4 31968.2 51521.0 51710.5 51801.0 52898.0 53256.2 42582.8 43224.4 43766.1 43816.8 45301.0 42381.6 42546.4 43057.1 43315.6 43648.0 44874.0 44897.3 45455.5 46028.5 46329.5 37142.0 37306.0 37452.8 37688.6 38189.6 29172.6 30304.4 30384.7 30748.5 30918.0 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#2] jquery.html Cycles:180 Average:30654.73 Median:11517.90 stddev:89272.84 (775.1%) stddev-sans-first:89494.43 00:56:25 INFO - PROCESS | 4374 | Values: 430.6 431.5 444.4 445.3 455.8 18517.0 18738.6 19259.9 20850.3 20939.3 18389.2 19042.6 19353.1 19395.4 19458.4 5248.8 5355.0 5392.4 5394.5 5421.6 5327.0 5383.4 5422.4 5442.2 5790.6 5759.6 5774.4 5783.0 5800.5 5808.7 5642.2 5757.5 5792.0 5841.5 5903.5 5745.4 5764.3 5774.5 5777.8 5779.8 14085.7 14682.9 14683.1 14690.9 14692.9 2532.2 2535.4 2553.3 2571.0 2920.9 10114.9 10404.8 10714.8 10803.4 10806.7 1809.3 1845.1 1908.1 1948.0 1970.3 76415.2 77303.0 78070.6 78448.2 78486.2 11452.5 11775.7 11783.2 11813.0 11832.6 16208.7 16296.8 16305.9 16325.3 16353.7 7761.7 8145.8 8174.5 8325.7 8336.0 7796.0 7860.2 7908.8 7976.7 8272.1 4862.0 4978.7 4988.2 5035.7 5045.9 2096.5 2147.3 2155.9 2164.4 2173.7 1030.4 1101.0 1119.9 1153.2 1182.8 19077.5 19104.9 19462.6 19468.7 19797.0 1127.7 1134.4 1175.3 1187.2 1211.6 10853.5 10892.5 11441.7 11568.7 11882.7 529113.0 533571.0 537154.0 553210.0 558603.0 94686.0 97291.5 98825.0 100126.0 100404.5 1152.1 1161.2 1170.6 1172.6 1185.3 18173.5 18187.4 18319.0 18385.9 18503.7 40626.4 41072.8 42370.4 42556.0 42563.0 60001.4 62170.4 62187.4 62421.0 62643.1 9189.4 9302.2 9306.4 9349.8 9527.1 12881.7 13550.7 13897.5 13939.2 14070.7 11737.4 11912.1 11953.3 12011.2 12118.3 11790.2 12074.8 12269.7 12332.3 12429.5 11956.3 11995.3 12001.0 12560.2 12697.7 9205.6 9287.4 9326.3 9338.4 9434.2 9747.0 12443.8 12545.4 12623.6 12680.2 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#3] mootools.html Cycles:180 Average:5561.84 Median:2862.72 stddev:3010.53 (105.2%) stddev-sans-first:3003.82 00:56:25 INFO - PROCESS | 4374 | Values: 1542.5 1552.4 1783.7 1897.5 1915.2 7504.0 8168.3 8186.6 8321.5 8381.5 8218.0 8245.0 8326.7 8449.9 8470.1 2353.1 2369.5 2379.7 2386.2 2388.8 2377.5 2423.6 2423.8 2432.5 2442.4 2365.9 2386.6 2393.0 2396.0 2404.2 2347.6 2381.6 2390.9 2395.4 2402.4 2402.3 2434.7 2447.1 2448.6 2449.7 8564.5 8614.8 8626.9 8631.1 8672.5 5181.1 5245.6 5264.6 5286.5 5289.0 3147.4 3202.3 3230.9 3351.0 3363.0 1066.7 1070.1 1087.1 1093.8 1097.9 10917.2 11111.6 11134.9 11145.8 11166.2 4564.5 4567.8 4594.5 4610.5 4654.3 9863.2 9898.3 9907.6 9956.3 9961.2 5232.7 5265.6 5308.9 5325.8 5336.3 4685.5 4757.8 4790.5 4812.2 4852.5 3957.5 3988.8 3992.8 4094.0 4125.6 1167.9 1189.1 1190.0 1196.5 1214.4 929.6 951.0 1013.5 1056.9 1076.9 6050.6 6144.5 6173.0 6176.9 6187.8 494.3 503.9 516.8 521.5 521.8 4326.2 4330.7 4341.8 4343.7 4347.5 10074.4 10274.1 10450.5 10460.8 10495.2 9696.8 10298.0 10312.1 10340.3 10360.3 7690.5 7714.7 7737.4 7759.7 7776.4 5638.7 5870.5 5925.7 5939.4 5998.4 9021.5 9051.5 9086.4 9096.5 9210.3 9068.1 9107.7 9125.7 9325.2 9329.3 7242.9 7253.6 7411.1 7412.9 7436.9 7927.6 7940.8 7955.1 7983.2 8009.6 7045.6 7090.9 7141.3 7169.3 7182.7 6814.8 6866.5 6872.0 6873.3 7058.5 6584.3 6728.0 6745.8 6761.4 6816.0 5203.9 5238.5 5242.3 5253.5 5333.1 5000.4 5146.0 5151.3 5164.5 5217.4 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#4] prototype.html Cycles:180 Average:5801.48 Median:6672.40 stddev:1780.03 (26.7%) stddev-sans-first:1737.43 00:56:25 INFO - PROCESS | 4374 | Values: 354.1 357.6 363.2 372.7 372.9 6447.3 6448.9 6453.7 6479.5 6609.9 6499.3 6544.2 6568.2 6577.6 6585.7 4932.1 4942.0 4947.3 4948.5 4951.6 4938.4 4945.5 4953.2 4970.7 4974.8 4917.2 4920.7 4922.0 4932.6 4933.7 4689.0 4921.7 4923.2 4923.9 4925.3 4257.1 4267.1 4277.9 4278.2 4283.7 6224.3 6245.8 6246.9 6261.1 6266.6 5688.2 5693.9 5698.5 5707.4 5708.0 6775.9 6784.1 6788.7 6793.9 6794.0 4603.7 4776.4 4777.1 4781.2 4783.4 7113.7 7178.6 7200.4 7206.1 7220.4 4848.7 4871.8 4873.8 4874.2 4891.2 4939.6 4944.3 4945.6 4948.1 4949.0 5715.4 5722.5 5731.3 5732.5 5733.7 6667.6 6901.9 6908.3 6930.2 6937.5 1704.7 1719.9 1726.5 1728.1 1730.7 1128.7 1136.4 1139.6 1153.2 1157.3 6677.2 6821.4 6829.2 6836.8 6855.3 7206.6 7209.9 7230.1 7241.0 7241.4 6803.5 6813.4 6822.3 6829.8 6838.1 3840.2 3858.5 3867.5 3870.3 3876.6 7374.3 7514.9 7515.8 7516.8 7663.6 7363.4 7369.7 7375.8 7391.7 7397.7 7638.0 7639.6 7646.4 7653.7 7655.3 6962.0 7191.8 7192.7 7204.3 7213.6 7082.9 7112.9 7117.6 7126.5 7134.5 7513.1 7569.6 7572.1 7592.8 7637.8 4803.3 4834.5 4835.8 4836.1 4838.8 7016.2 7131.5 7134.4 7149.6 7161.7 6929.7 6957.1 6962.4 6968.3 6968.9 6874.2 6936.3 6937.6 6942.3 6957.2 6828.5 6829.5 6839.2 6842.7 6847.9 6856.2 6931.8 6941.9 6967.2 6985.3 6699.0 6811.6 6847.9 6851.1 6877.9 00:56:25 INFO - PROCESS | 4374 | 00:56:25 INFO - PROCESS | 4374 | [#5] yui.html Cycles:180 Average:15698.79 Median:24634.30 stddev:18254.74 (74.1%) stddev-sans-first:18271.91 00:56:25 INFO - PROCESS | 4374 | Values: 852.9 858.9 868.1 914.8 933.0 14396.2 15839.8 16035.1 16058.0 16076.7 14804.2 14847.9 14909.3 14917.9 14954.8 892.4 904.6 906.1 906.6 908.1 890.7 893.5 895.6 897.5 899.9 941.3 943.6 945.5 947.3 965.4 941.6 941.7 941.8 942.3 965.9 688.4 691.8 698.2 701.1 713.7 14336.4 14343.4 14370.5 14376.5 14376.7 14332.6 14500.9 14501.1 14509.8 14513.9 11731.7 11753.6 11840.5 11925.9 12107.5 3770.4 3925.3 3957.8 3988.7 4036.2 57193.7 57253.1 57307.7 57416.4 58145.8 11081.9 11087.4 11277.4 11357.4 11367.7 20441.5 20595.2 20636.0 20680.4 20707.0 8361.7 8448.3 8501.2 8543.5 8937.4 4628.2 4633.2 4633.3 4672.3 4757.4 3480.3 3533.7 3535.9 3535.9 3561.7 601.4 622.0 626.6 628.2 629.0 666.2 754.6 758.5 814.9 819.1 9490.0 9947.8 10013.8 10030.2 10085.8 695.6 746.8 784.7 809.3 809.8 4308.5 4406.1 4513.6 4523.7 4558.7 66539.7 66857.0 67840.0 67856.0 72127.0 53637.5 53858.0 54409.0 57069.7 59592.1 53196.5 53257.9 53562.0 53980.5 55385.7 9661.9 9684.7 9733.8 9755.4 9769.3 37780.0 37990.2 38257.8 38464.8 39105.2 44755.0 45158.5 49236.0 50506.7 50796.7 12768.6 13049.5 13109.6 13162.1 13484.9 13631.0 13956.4 14032.6 14342.3 14551.6 12834.6 12894.2 13015.2 13023.2 13326.0 11942.6 12413.4 12911.8 13028.5 13990.8 12758.9 12976.4 13089.3 13874.7 14441.9 10841.9 10995.8 11019.2 11124.1 11206.0 10324.3 10563.2 10588.7 10645.8 10648.3 00:56:25 INFO - PROCESS | 4374 | -------- Summary: end -------- 00:56:25 INFO - PROCESS | 4374 | 00:56:26 INFO - TEST-INFO | 4374: exit 0 00:56:26 INFO - TEST-OK | dromaeo_css | took 1108255ms 00:56:26 INFO - TEST-START | kraken 00:56:26 INFO - operating with platform_type : linux_ 00:56:26 INFO - Initialising browser for kraken test... 00:56:26 INFO - TEST-INFO | started process 4610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw7yvil/profile http://localhost:55342/getInfo.html) 00:56:29 INFO - PROCESS | 4610 | 00:56:29 INFO - PROCESS | 4610 | (process:4685): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:56:30 INFO - PROCESS | 4610 | __metrics Screen width/height:1600/1200 00:56:30 INFO - PROCESS | 4610 | colorDepth:24 00:56:30 INFO - PROCESS | 4610 | Browser inner width/height: 1024/697 00:56:30 INFO - PROCESS | 4610 | __metrics 00:56:31 ERROR - PROCESS | 4610 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 00:56:32 INFO - TEST-INFO | 4610: exit 0 00:56:32 INFO - Browser initialized. 00:56:32 INFO - Running cycle 1/1 for kraken test... 00:56:32 INFO - TEST-INFO | started process 4736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw7yvil/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:56:33 INFO - PROCESS | 4736 | 00:56:33 INFO - PROCESS | 4736 | (process:4804): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 00:56:43 INFO - PROCESS | 4736 | RSS: Main: 150712320 00:56:43 INFO - PROCESS | 4736 | 00:56:46 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55342/tests/kraken/driver.html?testName=audio-beat-detection) 00:56:47 INFO - PROCESS | 4736 | RSS: Main: 156659712 00:56:47 INFO - PROCESS | 4736 | 00:56:49 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55342/tests/kraken/driver.html?testName=audio-dft) 00:56:50 INFO - PROCESS | 4736 | RSS: Main: 156393472 00:56:50 INFO - PROCESS | 4736 | 00:56:53 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55342/tests/kraken/driver.html?testName=audio-fft) 00:56:53 INFO - PROCESS | 4736 | RSS: Main: 156389376 00:56:53 INFO - PROCESS | 4736 | 00:56:55 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55342/tests/kraken/driver.html?testName=audio-oscillator) 00:56:56 INFO - PROCESS | 4736 | RSS: Main: 156196864 00:56:56 INFO - PROCESS | 4736 | 00:56:58 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:56:59 INFO - PROCESS | 4736 | RSS: Main: 156241920 00:56:59 INFO - PROCESS | 4736 | 00:57:02 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55342/tests/kraken/driver.html?testName=imaging-darkroom) 00:57:03 INFO - PROCESS | 4736 | RSS: Main: 156311552 00:57:03 INFO - PROCESS | 4736 | 00:57:06 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55342/tests/kraken/driver.html?testName=imaging-desaturate) 00:57:06 INFO - PROCESS | 4736 | RSS: Main: 156459008 00:57:06 INFO - PROCESS | 4736 | 00:57:09 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55342/tests/kraken/driver.html?testName=json-parse-financial) 00:57:10 INFO - PROCESS | 4736 | RSS: Main: 156233728 00:57:10 INFO - PROCESS | 4736 | 00:57:11 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:57:12 INFO - PROCESS | 4736 | RSS: Main: 155967488 00:57:12 INFO - PROCESS | 4736 | 00:57:14 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:57:14 INFO - PROCESS | 4736 | RSS: Main: 156078080 00:57:14 INFO - PROCESS | 4736 | 00:57:16 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:57:17 INFO - PROCESS | 4736 | RSS: Main: 156262400 00:57:17 INFO - PROCESS | 4736 | 00:57:19 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:57:20 INFO - PROCESS | 4736 | RSS: Main: 156680192 00:57:20 INFO - PROCESS | 4736 | 00:57:23 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:57:23 INFO - PROCESS | 4736 | RSS: Main: 156700672 00:57:23 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | Cycle 1(1): loaded http://localhost:55342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55342/tests/kraken/driver.html?testName=ai-astar) 00:57:25 INFO - PROCESS | 4736 | RSS: Main: 157876224 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | __start_tp_report 00:57:25 INFO - PROCESS | 4736 | _x_x_mozilla_page_load 00:57:25 INFO - PROCESS | 4736 | _x_x_mozilla_page_load_details 00:57:25 INFO - PROCESS | 4736 | |i|pagename|runs| 00:57:25 INFO - PROCESS | 4736 | |0;ai-astar;108;111;103;110;112;111;101;111;110;110 00:57:25 INFO - PROCESS | 4736 | |1;audio-beat-detection;160;134;151;174;135;152;158;128;181;125 00:57:25 INFO - PROCESS | 4736 | |2;audio-dft;162;164;161;162;164;163;160;163;164;163 00:57:25 INFO - PROCESS | 4736 | |3;audio-fft;76;73;77;174;74;76;76;74;164;73 00:57:25 INFO - PROCESS | 4736 | |4;audio-oscillator;94;93;148;92;94;93;139;92;93;140 00:57:25 INFO - PROCESS | 4736 | |5;imaging-gaussian-blur;117;118;118;118;117;117;117;117;117;116 00:57:25 INFO - PROCESS | 4736 | |6;imaging-darkroom;147;146;146;146;146;147;147;146;146;147 00:57:25 INFO - PROCESS | 4736 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;96 00:57:25 INFO - PROCESS | 4736 | |8;json-parse-financial;55;56;59;56;56;59;57;75;55;58 00:57:25 INFO - PROCESS | 4736 | |9;json-stringify-tinderbox;59;60;59;58;60;59;62;59;59;59 00:57:25 INFO - PROCESS | 4736 | |10;stanford-crypto-aes;73;75;73;73;74;74;74;74;81;74 00:57:25 INFO - PROCESS | 4736 | |11;stanford-crypto-ccm;116;121;115;112;116;116;114;114;131;137 00:57:25 INFO - PROCESS | 4736 | |12;stanford-crypto-pbkdf2;163;160;161;160;160;160;157;171;160;162 00:57:25 INFO - PROCESS | 4736 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;66;68;67;66;66 00:57:25 INFO - PROCESS | 4736 | __end_tp_report 00:57:25 INFO - PROCESS | 4736 | __start_cc_report 00:57:25 INFO - PROCESS | 4736 | _x_x_mozilla_cycle_collect,853 00:57:25 INFO - PROCESS | 4736 | __end_cc_report 00:57:25 INFO - PROCESS | 4736 | __startTimestamp1467878245739__endTimestamp 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | ------- Summary: start ------- 00:57:25 INFO - PROCESS | 4736 | Number of tests: 14 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.50 stddev:3.71 (3.4%) stddev-sans-first:3.93 00:57:25 INFO - PROCESS | 4736 | Values: 108.0 111.0 103.0 110.0 112.0 111.0 101.0 111.0 110.0 110.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:155.00 stddev:19.14 (12.3%) stddev-sans-first:19.94 00:57:25 INFO - PROCESS | 4736 | Values: 160.0 134.0 151.0 174.0 135.0 152.0 158.0 128.0 181.0 125.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.35 (0.8%) stddev-sans-first:1.41 00:57:25 INFO - PROCESS | 4736 | Values: 162.0 164.0 161.0 162.0 164.0 163.0 160.0 163.0 164.0 163.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#3] audio-fft Cycles:10 Average:93.70 Median:75.00 stddev:39.78 (53.0%) stddev-sans-first:41.67 00:57:25 INFO - PROCESS | 4736 | Values: 76.0 73.0 77.0 174.0 74.0 76.0 76.0 74.0 164.0 73.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#4] audio-oscillator Cycles:10 Average:107.80 Median:93.00 stddev:23.95 (25.8%) stddev-sans-first:24.88 00:57:25 INFO - PROCESS | 4736 | Values: 94.0 93.0 148.0 92.0 94.0 93.0 139.0 92.0 93.0 140.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 00:57:25 INFO - PROCESS | 4736 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:57:25 INFO - PROCESS | 4736 | Values: 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 147.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:57:25 INFO - PROCESS | 4736 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:57.50 stddev:5.95 (10.3%) stddev-sans-first:6.16 00:57:25 INFO - PROCESS | 4736 | Values: 55.0 56.0 59.0 56.0 56.0 59.0 57.0 75.0 55.0 58.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.00 stddev:1.07 (1.8%) stddev-sans-first:1.13 00:57:25 INFO - PROCESS | 4736 | Values: 59.0 60.0 59.0 58.0 60.0 59.0 62.0 59.0 59.0 59.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.00 stddev:2.37 (3.2%) stddev-sans-first:2.45 00:57:25 INFO - PROCESS | 4736 | Values: 73.0 75.0 73.0 73.0 74.0 74.0 74.0 74.0 81.0 74.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:116.00 stddev:8.26 (7.1%) stddev-sans-first:8.68 00:57:25 INFO - PROCESS | 4736 | Values: 116.0 121.0 115.0 112.0 116.0 116.0 114.0 114.0 131.0 137.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:160.50 stddev:3.72 (2.3%) stddev-sans-first:3.90 00:57:25 INFO - PROCESS | 4736 | Values: 163.0 160.0 161.0 160.0 160.0 160.0 157.0 171.0 160.0 162.0 00:57:25 INFO - PROCESS | 4736 | 00:57:25 INFO - PROCESS | 4736 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 00:57:25 INFO - PROCESS | 4736 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 68.0 67.0 66.0 66.0 00:57:25 INFO - PROCESS | 4736 | -------- Summary: end -------- 00:57:25 INFO - PROCESS | 4736 | 00:57:26 INFO - TEST-INFO | 4736: exit 0 00:57:26 INFO - TEST-OK | kraken | took 60101ms 00:57:26 INFO - SUITE-END | took 1168s 00:57:26 INFO - Completed test suite (00:19:28) 00:57:26 INFO - javascript benchmark 00:57:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3263.820489873057, 3314.419976504111, 3325.0357396355057, 3339.465685490322, 3348.0458069450196, 5464.207689884965, 5476.78092876285, 5501.312335958005, 5530.834074977747, 5531.91702124468, 5441.537469315103, 5473.2063850741615, 5479.4520547945185, 5498.5876059295515, 5503.11950087986, 4989.75051247438, 5010.348654674887, 5047.2176812593925, 5063.721495317756, 5066.1387564114, 4939.654224204289, 4940.5306495883015, 4992.775325110379, 5002.399712034561, 5088.211327244283, 5027.673201241926, 5039.420466646346, 5054.924176137342, 5061.848144555651, 5062.759623892133, 5010.849674509753, 5020.171671674169, 5026.79892804291, 5031.270465782478, 5053.74731263439, 4891.951080489185, 4899.657024008321, 4935.5804756595735, 4967.801287948478, 4969.13040217964, 5231.790728370861, 5234.1887007513515, 5245.134552798783, 5264.42091369949, 5303.045451818671, 5694.088945768657, 5713.971430142864, 5719.628224165416, 5738.167965645, 5756.65460072397, 5768.278965129359, 5785.27684039495, 5828.737706803204, 5867.354590994987, 5867.501262392701, 5482.862928426782, 5484.012877682016, 5488.313960754906, 5489.066858634042, 5490.945090549083, 5911.527077833849, 5961.821145365646, 5975.910361344583, 5978.0, 5986.940130598726, 5661.235733176051, 5756.5682573807135, 5804.796832110856, 5821.039528477839, 5842.182094506772, 5808.361080281165, 5811.88376232473, 5813.680247586423, 5816.738246778905, 5821.970890145607, 5805.94194058054, 5811.186433899257, 5813.709314534256, 5814.476697097197, 5818.44724751148, 5849.151872978395, 5908.940910590925, 5911.793087241926, 5933.169356290123, 5943.70281485924, 4498.50516443191, 4501.437320334958, 4527.049319642846, 4530.88672783183, 4558.954410455853, 3933.3116704576582, 4002.3396139637216, 4059.715819892579, 4086.366613174963, 4093.8771836844944, 5430.864228394322, 5559.138333558305, 5683.062294721407, 5683.147527870852, 5731.168980497804, 5823.970880145572, 5837.211976383219, 5852.385499522489, 5853.765849366063, 5883.0, 5539.2522009529, 5603.327600687943, 5637.577181711388, 5643.1535269709875, 5648.85877853057, 4682.85951421451, 4787.712737235707, 4842.104210720958, 4872.731999739977, 4873.19592267279, 6161.784337548164, 6197.380261973857, 6199.535034872402, 6210.378962103753, 6220.813375598739, 5760.222369979999, 5912.467877890925, 5917.437843404869, 5929.140274660236, 5944.5838791284195, 6049.062395328731, 6125.0, 6127.250613123855, 6130.948521379913, 6142.754289828356, 5710.971445142914, 5764.221830052889, 5781.190633311256, 5784.913226301524, 5789.91315130265, 5684.118961560965, 5828.242328497268, 5837.912431313619, 5842.065269556851, 5854.121881717776, 5689.800856969986, 5708.315002199763, 5709.65742055478, 5729.0, 5760.654360738369, 5673.0, 5695.202671625892, 5696.743646535833, 5703.258576385043, 5724.656520608777, 5541.307336582927, 5559.082751345983, 5570.498655121059, 5595.216669666332, 5615.634983726045, 5752.827415177551, 5776.537876969748, 5781.161731548986, 5786.652800831964, 5792.623479473821, 5622.522085622604, 5673.205751194919, 5680.204771331934, 5685.658860468385, 5687.630304030225], "value": 5403.071406469328, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.733706517393, 672.7981605518344, 678.0845858091577, 681.9590824550526, 682.522234435895, 39957.20085598286, 41261.17477650445, 41337.75986720396, 41421.58578414215, 41460.17079658409, 44723.55276447243, 45431.54568454315, 45506.54493455064, 45543.544564554424, 45559.77220113895, 8843.425177363482, 9101.180893719564, 9101.95449022754, 9108.45349279042, 9115.908840911605, 9056.0, 9182.816343673123, 9200.263978881707, 9215.861762073575, 9219.0, 9241.306901982345, 9267.814643707121, 9311.0, 9323.30075244356, 9342.486163261017, 9143.862842057375, 9183.448993060438, 9188.586513606904, 9213.262938964866, 9241.445513269226, 9154.588043538057, 9252.907470925273, 9253.259739220846, 9279.953600232024, 9289.767755806091, 43391.0, 44248.55751442476, 44289.77855110704, 44297.11405771899, 44383.0, 3690.6862916652117, 3896.1038961038835, 4203.831846726158, 4210.136921930997, 4532.4334458192725, 33463.498047529305, 33543.49684754731, 33848.49227261593, 33868.83065584656, 33981.98054058382, 4238.851640192609, 4270.701050926436, 4279.144171165748, 4328.394024836525, 4458.242098843204, 333831.0, 334694.0, 336119.0, 337221.0, 337553.0, 65192.67403663046, 65223.34776652173, 65597.0, 65657.0, 65732.34267657262, 72598.0, 73429.26570734331, 73454.6327268371, 74109.0, 74189.6290518544, 18786.90606546986, 18949.810501894804, 19057.90471047636, 19068.33260835864, 19094.0, 14382.424703011762, 14421.278936053155, 14478.203698796668, 14503.274836258144, 14591.708165836624, 21685.349439516838, 21701.67447488289, 21783.455413614785, 21922.0, 21944.670829937564, 7585.658645360972, 7798.376129909594, 8052.959735201403, 8251.546164960864, 8298.0, 1201.9519219231308, 1223.5900973174087, 1239.913206075566, 1312.3635037007043, 1325.5758157389544, 33571.496427553604, 34200.31599368049, 34276.82861585726, 34635.13412164716, 34717.82641086778, 1217.3243849663345, 1232.3160645841465, 1284.0082607524446, 1329.0497294434526, 1331.633800704814, 17698.96521158871, 17899.73150402745, 18017.639647207245, 18026.909865450853, 18120.36578719765, 489643.0, 498845.0, 595003.0, 602001.0, 791945.0, 64451.0, 65066.34933650697, 65121.67439162774, 65292.34707652958, 65454.0, 1523.7333466643292, 1559.5945054285967, 1577.1010524001438, 1589.435750308647, 1594.8628837357996, 33958.66041339555, 34635.0, 34647.4802877952, 35026.299474010884, 35058.298834022666, 56221.71889140528, 57227.0, 57262.0, 57313.0, 57379.42620573741, 461292.0, 465174.0, 466425.0, 467788.0, 470422.0, 31270.53094203634, 31474.37051258916, 31716.524252135776, 31938.36123277475, 31968.200794980312, 51521.0, 51710.482895170564, 51801.0, 52898.0, 53256.2011569819, 42582.787086064374, 43224.35163472487, 43766.12467750691, 43816.78091609522, 45301.0, 42381.57618423776, 42546.361804572334, 43057.13885722205, 43315.56684433115, 43648.0, 44874.0, 44897.32654010127, 45455.54544454513, 46028.539714602426, 46329.53670463252, 37142.0, 37306.0, 37452.812735936146, 37688.62311376961, 38189.618103818604, 29172.56241156342, 30304.393912122076, 30384.696153038185, 30748.538771917993, 30918.0], "value": 21798.04545288729, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.55222568528734, 431.4649834205584, 444.4355867346941, 445.3395219032821, 455.79944824277294, 18517.0, 18738.62522749546, 19259.903700481496, 20850.270240541584, 20939.267125650604, 18389.172487238073, 19042.619147617075, 19353.129109190086, 19395.418137455865, 19458.416247512563, 5248.790048398059, 5355.0, 5392.352917649888, 5394.487523685244, 5421.620486565942, 5326.973365133169, 5383.380911195204, 5422.4306447823, 5442.210879422481, 5790.594658373915, 5759.625624334405, 5774.3936886626925, 5783.016887129177, 5800.53595712342, 5808.709564521778, 5642.153676948449, 5757.539396848242, 5792.044312688401, 5841.474267315941, 5903.527717782567, 5745.425457454263, 5764.33710123337, 5774.48029677331, 5777.7977770777825, 5779.797707080274, 14085.71828563423, 14682.853171468256, 14683.119012859263, 14690.853091469162, 14692.853071469362, 2532.227670560478, 2535.378832186108, 2553.323369307135, 2571.048711976562, 2920.8977685780897, 10114.949425252827, 10404.791904161875, 10714.785704285949, 10803.4058126803, 10806.675799726021, 1809.267246765049, 1845.1420089658238, 1908.0745838268429, 1947.9902600487048, 1970.3103913630114, 76415.23584764192, 77303.0, 78070.60964695197, 78448.21551784466, 78486.19297396294, 11452.484638191301, 11775.705607359885, 11783.175177737647, 11813.0, 11832.645020649394, 16208.675826483404, 16296.83703162977, 16305.918470407572, 16325.265363058454, 16353.672926541403, 7761.68953241864, 8145.796355091052, 8174.509529428254, 8325.708600198965, 8336.0, 7795.961020194863, 7860.174681658458, 7908.762737117896, 7976.680932762624, 8272.090070092285, 4861.951380486221, 4978.701277923336, 4988.152014157529, 5035.697858128524, 5045.949540504622, 2096.528281136732, 2147.302126808793, 2155.8706477611395, 2164.426426996847, 2173.739151301854, 1030.4178139351243, 1101.0145919402091, 1119.9328040317607, 1153.2125205930774, 1182.8225766134976, 19077.523061923563, 19104.904475477535, 19462.610747784965, 19468.70796938047, 19797.0, 1127.7293449572044, 1134.427114307286, 1175.26545908807, 1187.1749134351542, 1211.6425654431964, 10853.51159197838, 10892.455377231265, 11441.713957151138, 11568.710782230512, 11882.702932426759, 529113.0, 533571.0, 537154.0, 553210.0, 558603.0, 94686.0, 97291.51354243183, 98825.0, 100126.0, 100404.4979775111, 1152.0668258710305, 1161.2393882007298, 1170.5610396101463, 1172.6482055383522, 1185.2947496239724, 18173.45479635613, 18187.363442279457, 18319.0, 18385.90807045956, 18503.722444163617, 40626.39060414037, 41072.79463602663, 42370.36444453274, 42556.0, 42563.0, 60001.39998599958, 62170.37829621646, 62187.37812621997, 62421.0, 62643.06035409381, 9189.448633082036, 9302.209312208539, 9306.441613503212, 9349.813003739751, 9527.09492598202, 12881.742365152457, 13550.728985420434, 13897.513587024405, 13939.233342166279, 14070.718585628025, 11737.35444550558, 11912.10659200546, 11953.282803031845, 12011.219270747373, 12118.333491657691, 11790.174687772116, 12074.75850483003, 12269.69325766863, 12332.32172230536, 12429.502819887104, 11956.34240116767, 11995.280283183038, 12001.0, 12560.183588066746, 12697.746045079231, 9205.631774728936, 9287.396319239228, 9326.347155699308, 9338.439693618133, 9434.150926416656, 9747.0, 12443.75112497763, 12545.372731363213, 12623.621291361274, 12680.23918564889], "value": 9504.85116494703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1542.467848592236, 1552.371289627701, 1783.652187823374, 1897.506648271449, 1915.224334144672, 7503.962480187592, 8168.264856162944, 8186.631601577928, 8321.54231517267, 8381.497110173386, 8217.958910205441, 8244.958775206116, 8326.708565200219, 8449.873251901212, 8470.068292487822, 2353.141103497224, 2369.526094781042, 2379.7382287948312, 2386.2364043506086, 2388.7850093491584, 2377.524495100978, 2423.587990041697, 2423.8182136339756, 2432.5499782540196, 2442.4016116051503, 2365.881705914706, 2386.606209975352, 2393.018862266471, 2395.9880200598973, 2404.2426635609813, 2347.6478528220905, 2381.57131716291, 2390.8804559771943, 2395.4490467192645, 2402.447437089462, 2402.2913240593894, 2434.7443518430487, 2447.070113356931, 2448.5592593333195, 2449.742777008424, 8564.528950907697, 8614.827703445895, 8626.870596941051, 8631.05058443577, 8672.479651220883, 5181.093308670967, 5245.606579506552, 5264.578833693296, 5286.471352864722, 5288.9735551322, 3147.4334619768433, 3202.2794871153806, 3230.9030729078167, 3350.983245083759, 3362.9831850840587, 1066.7305905971868, 1070.1064611049783, 1087.1357270969597, 1093.792179485895, 1097.9011888930036, 10917.181211409097, 11111.611093611686, 11134.944325278322, 11145.832812507819, 11166.218364714474, 4564.543545645409, 4567.771611419415, 4594.517575654575, 4610.515895830957, 4654.2785868190485, 9863.161631261422, 9898.257630677585, 9907.554160062815, 9956.253281003954, 9961.203103751683, 5232.73836308183, 5265.605079619044, 5308.867278318073, 5325.840224793263, 5336.252924590561, 4685.531446855355, 4757.833475828329, 4790.520947905182, 4812.205986012339, 4852.490488498727, 3957.485526881487, 3988.8404463821703, 3992.760434373889, 4094.0379010932406, 4125.566815484391, 1167.9240849344765, 1189.1319336884123, 1189.9583514576948, 1196.485511230162, 1214.36245970866, 929.5723966975268, 950.9904900950902, 1013.5033833421718, 1056.8943105689523, 1076.8761592416815, 6050.6369617823075, 6144.5084393248435, 6173.043178307369, 6176.8764624707255, 6187.783427580103, 494.3079688436218, 503.93700787401576, 516.8268630008914, 521.5202014146994, 521.8460554136539, 4326.17802617508, 4330.696851220384, 4341.7829108545075, 4343.717658352197, 4347.500037495728, 10074.395536267848, 10274.075333220046, 10450.529726162342, 10460.843087353696, 10495.160387169008, 9696.806063878683, 10298.0, 10312.071913527818, 10340.27618066728, 10360.326578772356, 7690.538567685845, 7714.72998445063, 7737.419693523008, 7759.728409505753, 7776.416768742367, 5638.718064096696, 5870.530357571299, 5925.674087925033, 5939.376365481735, 5998.370171131968, 9021.503817290111, 9051.547422628973, 9086.363954523384, 9096.454212747256, 9210.309226808151, 9068.093190681144, 9107.681231156877, 9125.680601178927, 9325.160735533835, 9329.253659707072, 7242.927570724225, 7253.637318134178, 7411.0736157980255, 7412.888806667796, 7436.888446673413, 7927.603619819101, 7940.761777146695, 7955.0851652060755, 7983.20167983197, 8009.639566219651, 7045.577265364094, 7090.929090709027, 7141.285871412817, 7169.318914703304, 7182.712691492491, 6814.795556133324, 6866.485013624098, 6872.037914691847, 6873.347032031949, 7058.470614703815, 6584.308647591934, 6728.0, 6745.763898263537, 6761.391474767294, 6816.0457535946, 5203.921941170961, 5238.528532432099, 5242.318498595311, 5253.50091741284, 5333.06671332523, 5000.449950505515, 5145.974270128625, 5151.253068305, 5164.535191832753, 5217.373915130209], "value": 4473.984083378938, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.10588264631804, 357.61020487668446, 363.21545461802503, 372.7409450431951, 372.8583138407405, 6447.258565264996, 6448.935510644892, 6453.741850325987, 6479.481641468683, 6609.867802643957, 6499.317571654968, 6544.214694236698, 6568.244651865037, 6577.638229897354, 6585.736570537185, 4932.062908047477, 4941.975290123544, 4947.282644016615, 4948.505149485059, 4951.603871690274, 4938.3580134582635, 4945.455999840033, 4953.207486802113, 4970.676906001117, 4974.751262436882, 4917.21324588066, 4920.68015578988, 4922.0, 4932.556069953704, 4933.679310844784, 4688.976555117202, 4921.680090794105, 4923.18767403378, 4923.876903077452, 4925.26121081837, 4257.106007738379, 4267.146570685844, 4277.914441711148, 4278.187144442546, 4283.657307415399, 6224.3464436234, 6245.843853903643, 6246.87506249877, 6261.123442718023, 6266.592671476339, 5688.203651488795, 5693.857653558653, 5698.458646428583, 5707.429257074301, 5707.971460142714, 6775.864482710318, 6784.0841486399195, 6788.72845086196, 6793.898091528631, 6794.0, 4603.746793926366, 4776.402949631296, 4777.092352453023, 4781.163296423112, 4783.378160839104, 7113.715451381939, 7178.5692858428665, 7200.351968322876, 7206.1352637683285, 7220.350168484809, 4848.660593758403, 4871.805127794849, 4873.805047798049, 4874.19575770001, 4891.1685013547785, 4939.629527785431, 4944.307796908363, 4945.590506705572, 4948.084604348135, 4948.975255123702, 5715.399883012224, 5722.456366645162, 5731.340895797037, 5732.484076433141, 5733.684647344436, 6667.566608170453, 6901.930980690229, 6908.274631163756, 6930.237673855871, 6937.514373993873, 1704.7357659562788, 1719.8710096742793, 1726.507945235602, 1728.0668439043027, 1730.6625208084554, 1128.701992708392, 1136.4147464056018, 1139.5840518210794, 1153.1697178031804, 1157.3171828621155, 6677.23211830636, 6821.420179284816, 6829.180498340231, 6836.829079273058, 6855.280195579492, 7206.56760594366, 7209.927900721031, 7230.060092187982, 7241.0, 7241.42068634508, 6803.455723542104, 6813.420859226922, 6822.283660215705, 6829.760958366533, 6838.111045564145, 3840.1743625120735, 3858.5369755629504, 3867.497225360685, 3870.322693528621, 3876.6317199865966, 7374.3363097320425, 7514.887276690854, 7515.774526764206, 7516.849663006709, 7663.578503182379, 7363.374113200331, 7369.705211791468, 7375.778726638209, 7391.6673749681395, 7397.704091836374, 7638.045244344457, 7639.579823109671, 7646.426518011061, 7653.655585498666, 7655.272749088939, 6962.0, 7191.7842464726145, 7192.712291508281, 7204.3155900189395, 7213.567185968858, 7082.929170708227, 7112.857742845217, 7117.644117793986, 7126.465515086285, 7134.464915131282, 7513.1359893612935, 7569.621518924142, 7572.129205141259, 7592.772216833504, 7637.770866874002, 4803.255495398219, 4834.468208497133, 4835.758212089311, 4836.081144582518, 4838.806447742191, 7016.19313778922, 7131.500794944512, 7134.357907788324, 7149.571025738473, 7161.677724502514, 6929.68816403253, 6957.060796792368, 6962.408195303456, 6968.268331825086, 6968.860622787617, 6874.2094659112845, 6936.271691472322, 6937.618430986344, 6942.340477654615, 6957.234704182637, 6828.522003459909, 6829.453643708392, 6839.2476827547935, 6842.726290948306, 6847.897281540881, 6856.211535673262, 6931.757388491378, 6941.930580694128, 6967.198772141269, 6985.336393042653, 6699.0, 6811.591304521745, 6847.863042739018, 6851.143607049119, 6877.931220687729], "value": 5219.135393509738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [852.9104444033372, 858.8574623136708, 868.0885070675793, 914.8290188558645, 933.0436302789644, 14396.208208548525, 15839.841601583981, 16035.118068506228, 16058.036517808925, 16076.678466430694, 14804.185769782658, 14847.92576037121, 14909.32908019139, 14917.85082149181, 14954.775678364833, 892.370878530636, 904.6110172625769, 906.0576999920075, 906.6282824042144, 908.0646933658343, 890.692711014699, 893.5219657483248, 895.6372669069037, 897.4525539420948, 899.9145081217307, 941.3410612571193, 943.5942544705774, 945.5272363818091, 947.2989987409302, 965.3725078698832, 941.5715849288557, 941.7174847545778, 941.7833898203384, 942.3309450290268, 965.9130678238957, 688.3976520544524, 691.7682576336933, 698.1935864077, 701.0990876723386, 713.6538778692382, 14336.35486403104, 14343.354549045318, 14370.49703260381, 14376.496822611158, 14376.712465750627, 14332.57002289933, 14500.854991450162, 14501.129932203996, 14509.782353264709, 14513.854861451357, 11731.65813710384, 11753.647390578211, 11840.526378944833, 11925.940370298093, 12107.515699372014, 3770.4344348347695, 3925.2738243425056, 3957.8416863325433, 3988.660963818079, 4036.233115708006, 57193.71403142999, 57253.14120288199, 57307.713461432846, 57416.425835741524, 58145.8370832581, 11081.889181108247, 11087.445627718744, 11277.379744114152, 11357.37534435614, 11367.715807104889, 20441.48896277605, 20595.176192952415, 20636.0, 20680.379588612366, 20707.0, 8361.665533378718, 8448.32413406926, 8501.234888860032, 8543.530105844115, 8937.419067760704, 4628.236341003697, 4633.189191891405, 4633.258678611406, 4672.345871577982, 4757.405324334458, 3480.338735640271, 3533.699635531009, 3535.9469607955903, 3535.9469607955903, 3561.6972557332915, 601.425638515217, 622.0327390907092, 626.5864529410567, 628.214731585518, 629.0438533429253, 666.2038863558098, 754.5698951597647, 758.4577027425307, 814.8958161690942, 819.0867183090811, 9490.0, 9947.80104397908, 10013.799724005625, 10030.197584193247, 10085.798284034277, 695.5861262548775, 746.7834328044806, 784.6625950841193, 809.2797410304834, 809.7692157735017, 4308.482982042112, 4406.052698669801, 4513.593776560126, 4523.683342166082, 4558.749268790249, 66539.66730166318, 66857.0, 67840.0, 67856.0, 72127.0, 53637.46362536325, 53858.0, 54409.0, 57069.714651426475, 59592.10611840826, 53196.46803531915, 53257.93484130296, 53562.0, 53980.46019539833, 55385.72307138438, 9661.9033809661, 9684.70945871625, 9733.805323893625, 9755.414675119515, 9769.31614786958, 37780.0, 37990.24019519649, 38257.80871095627, 38464.80767596256, 39105.2178956425, 44755.0, 45158.54841451543, 49236.0, 50506.74746626243, 50796.74601626968, 12768.553100641433, 13049.543265985645, 13109.60671179866, 13162.14446061003, 13484.932575337061, 13630.967459927433, 13956.441742330193, 14032.649183770487, 14342.282885855457, 14551.636209094857, 12834.55079072228, 12894.226346419246, 13015.219086854819, 13023.153495022792, 13326.0, 11942.582009629621, 12413.44139513742, 12911.806322905351, 13028.478860845838, 13990.790138148139, 12758.915492183269, 12976.416061277076, 13089.280089595164, 13874.722505549631, 14441.927790360982, 10841.945790271313, 10995.780084398428, 11019.228653994143, 11124.110071194447, 11206.0, 10324.328918620266, 10563.20775941792, 10588.682339529827, 10645.787084258427, 10648.307859989076], "value": 7144.108239709919, "unit": "score"}], "name": "dromaeo_css", "value": 7560.453285197811, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 103.0, 110.0, 112.0, 111.0, 101.0, 111.0, 110.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 134.0, 151.0, 174.0, 135.0, 152.0, 158.0, 128.0, 181.0, 125.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 164.0, 163.0, 160.0, 163.0, 164.0, 163.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 77.0, 174.0, 74.0, 76.0, 76.0, 74.0, 164.0, 73.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 148.0, 92.0, 94.0, 93.0, 139.0, 92.0, 93.0, 140.0], "value": 107.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 59.0, 56.0, 56.0, 59.0, 57.0, 75.0, 55.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 58.0, 60.0, 59.0, 62.0, 59.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 73.0, 73.0, 74.0, 74.0, 74.0, 74.0, 81.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 121.0, 115.0, 112.0, 116.0, 116.0, 114.0, 114.0, 131.0, 137.0], "value": 119.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 160.0, 160.0, 160.0, 157.0, 171.0, 160.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 66.0, 66.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1521.4000000000003, "alertThreshold": 2.0}]} 00:57:27 INFO - Return code: 0 00:57:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:57:27 ERROR - # TBPL SUCCESS # 00:57:27 INFO - Running post-action listener: _resource_record_post_action 00:57:27 INFO - Running post-run listener: _resource_record_post_run 00:57:28 INFO - Total resource usage - Wall time: 1183s; CPU: 13.0%; Read bytes: 24576; Write bytes: 464314368; Read time: 16; Write time: 351460 00:57:28 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 242212864; Read time: 0; Write time: 228756 00:57:28 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 221564928; Read time: 0; Write time: 122704 00:57:28 INFO - Running post-run listener: _upload_blobber_files 00:57:28 INFO - Blob upload gear active. 00:57:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:57:28 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 00:57:28 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'] 00:57:28 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 00:57:28 INFO - (blobuploader) - INFO - Open directory for files ... 00:57:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:57:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:57:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:29 INFO - (blobuploader) - INFO - Done attempting. 00:57:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:57:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:57:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:57:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:57:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:57:30 INFO - (blobuploader) - INFO - Done attempting. 00:57:30 INFO - (blobuploader) - INFO - Iteration through files over. 00:57:30 INFO - Return code: 0 00:57:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:57:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:57:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46a6d3c6489add3c7ceb1c022991dda39253958728d11b3a546c7d74f306598c0f53dddf15a789a69bd988a96129be12b1845ad0181eabff9b74b327601783e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23644acb528e59a9309de9bc799494719dc5ee130aa47fcb3730d71703076742d13675f21657534bacbc6a201fc9900c514bd7e0281c548ebda011ef85513a7f"} 00:57:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:57:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:57:30 INFO - Contents: 00:57:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/46a6d3c6489add3c7ceb1c022991dda39253958728d11b3a546c7d74f306598c0f53dddf15a789a69bd988a96129be12b1845ad0181eabff9b74b327601783e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23644acb528e59a9309de9bc799494719dc5ee130aa47fcb3730d71703076742d13675f21657534bacbc6a201fc9900c514bd7e0281c548ebda011ef85513a7f"} 00:57:30 INFO - Running post-run listener: copy_logs_to_upload_dir 00:57:30 INFO - Copying logs to upload dir... 00:57:30 INFO - mkdir: /builds/slave/test/build/upload/logs 00:57:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.270646 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-07 00:57:30.001137) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:57:30.004993) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 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/46a6d3c6489add3c7ceb1c022991dda39253958728d11b3a546c7d74f306598c0f53dddf15a789a69bd988a96129be12b1845ad0181eabff9b74b327601783e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23644acb528e59a9309de9bc799494719dc5ee130aa47fcb3730d71703076742d13675f21657534bacbc6a201fc9900c514bd7e0281c548ebda011ef85513a7f"} 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.011222 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/46a6d3c6489add3c7ceb1c022991dda39253958728d11b3a546c7d74f306598c0f53dddf15a789a69bd988a96129be12b1845ad0181eabff9b74b327601783e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/23644acb528e59a9309de9bc799494719dc5ee130aa47fcb3730d71703076742d13675f21657534bacbc6a201fc9900c514bd7e0281c548ebda011ef85513a7f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 00:57:30.030675) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 00:57:30.031005) ========= 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=a0d2d2de893abaa8702a9954000001a7-1467876854.62200-485196160 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 00:57:30.117858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:57:30.118181) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 00:57:30.118488) ========= ========= Total master_lag: 0.18 =========