builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-017 starttime: 1490363857.91 results: success (0) revision: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:37.915176) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:37.915915) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:37.916195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:37.952384) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:37.952628) ========= 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=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-24 06:57:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-03-24 06:57:38 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134070 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.100391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.100723) ========= 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=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.150721) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.151080) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd --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=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-24 06:57:38,426 truncating revision to first 12 chars 2017-03-24 06:57:38,427 Setting DEBUG logging. 2017-03-24 06:57:38,427 attempt 1/10 2017-03-24 06:57:38,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c987b7ed54a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 06:57:38,727 unpacking tar archive at: mozilla-central-4c987b7ed54a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.700755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.862716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.863026) ========= script_repo_revision: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.863385) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.863640) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 06:57:38.870945) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-24 06:57:38.871221) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:39 INFO - MultiFileLogger online at 20170324 06:57:39 in /builds/slave/test 06:57:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:57:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:39 INFO - {'append_to_log': False, 06:57:39 INFO - 'base_work_dir': '/builds/slave/test', 06:57:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:57:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:39 INFO - 'branch': 'Firefox-Non-PGO', 06:57:39 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:39 INFO - 'config_files': ('talos/linux_config.py',), 06:57:39 INFO - 'default_actions': ('clobber', 06:57:39 INFO - 'read-buildbot-config', 06:57:39 INFO - 'download-and-extract', 06:57:39 INFO - 'populate-webroot', 06:57:39 INFO - 'create-virtualenv', 06:57:39 INFO - 'install', 06:57:39 INFO - 'run-tests'), 06:57:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:39 INFO - 'download_minidump_stackwalk': True, 06:57:39 INFO - 'download_symbols': 'ondemand', 06:57:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:39 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:39 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:39 INFO - 'gecko_profile': False, 06:57:39 INFO - 'gecko_profile_interval': 0, 06:57:39 INFO - 'installer_path': 'installer.exe', 06:57:39 INFO - 'log_level': 'info', 06:57:39 INFO - 'log_name': 'talos', 06:57:39 INFO - 'log_to_console': True, 06:57:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:39 INFO - 'opt_config_files': (), 06:57:39 INFO - 'pip_index': False, 06:57:39 INFO - 'suite': 'dromaeojs-e10s', 06:57:39 INFO - 'system_bits': '32', 06:57:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:39 INFO - 'title': 'talos-linux64-ix-017', 06:57:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:39 INFO - 'use_talos_json': True, 06:57:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:39 INFO - 'work_dir': 'build'} 06:57:39 INFO - [mozharness: 2017-03-24 13:57:39.247004Z] Running clobber step. 06:57:39 INFO - Running pre-action listener: _resource_record_pre_action 06:57:39 INFO - Running main action method: clobber 06:57:39 INFO - rmtree: /builds/slave/test/build 06:57:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:40 INFO - Running post-action listener: _resource_record_post_action 06:57:40 INFO - [mozharness: 2017-03-24 13:57:40.709233Z] Finished clobber step (success) 06:57:40 INFO - [mozharness: 2017-03-24 13:57:40.709335Z] Running read-buildbot-config step. 06:57:40 INFO - Running pre-action listener: _resource_record_pre_action 06:57:40 INFO - Running main action method: read_buildbot_config 06:57:40 INFO - Using buildbot properties: 06:57:40 INFO - { 06:57:40 INFO - "project": "", 06:57:40 INFO - "product": "firefox", 06:57:40 INFO - "who": "cbook@mozilla.com", 06:57:40 INFO - "installer_path": "public/build/target.tar.bz2", 06:57:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:57:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:57:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:57:40 INFO - "stage_platform": "linux64", 06:57:40 INFO - "basedir": "/builds/slave/test", 06:57:40 INFO - "buildnumber": 734, 06:57:40 INFO - "platform": "ubuntu64_hw", 06:57:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:57:40 INFO - "slavebuilddir": "test", 06:57:40 INFO - "taskId": "S8QTBWs4RKS4OCyxM3zfbA", 06:57:40 INFO - "branch": "mozilla-central", 06:57:40 INFO - "script_repo_revision": "production", 06:57:40 INFO - "revision": "4c987b7ed54a630a7de76adcc2eb00dab49d5dfd", 06:57:40 INFO - "slavename": "talos-linux64-ix-017", 06:57:40 INFO - "repo_path": "mozilla-central" 06:57:40 INFO - } 06:57:40 INFO - Finding installer, test and symbols from parent task. 06:57:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8QTBWs4RKS4OCyxM3zfbA'}, attempt #1 06:57:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S8QTBWs4RKS4OCyxM3zfbA'}, attempt #1 06:57:41 INFO - Task dependencies: EXURsPqFRXmx5uvPxmZMtA 06:57:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA'}, attempt #1 06:57:42 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 06:57:42 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/test_packages.json 06:57:42 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.crashreporter-symbols.zip 06:57:42 INFO - Running post-action listener: _resource_record_post_action 06:57:42 INFO - [mozharness: 2017-03-24 13:57:42.068276Z] Finished read-buildbot-config step (success) 06:57:42 INFO - [mozharness: 2017-03-24 13:57:42.068494Z] Running download-and-extract step. 06:57:42 INFO - Running pre-action listener: _resource_record_pre_action 06:57:42 INFO - Running main action method: download_and_extract 06:57:42 INFO - mkdir: /builds/slave/test/build/tests 06:57:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:42 INFO - trying https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.test_packages.json 06:57:42 INFO - Downloading https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:57:42 INFO - Downloaded 986 bytes. 06:57:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:57:42 INFO - Using the following test package requirements: 06:57:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:57:42 INFO - u'common': [u'target.common.tests.zip'], 06:57:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:57:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:57:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:57:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:57:42 INFO - u'mozbase': [u'target.common.tests.zip'], 06:57:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:57:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:57:42 INFO - u'web-platform': [u'target.common.tests.zip', 06:57:42 INFO - u'target.web-platform.tests.zip'], 06:57:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:57:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip 06:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip into memory 06:57:44 INFO - Expected file size: 58125549 06:57:44 INFO - Obtained file size: 58125549 06:57:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:57:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip 06:57:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:57:54 INFO - Fetch https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.common.tests.zip into memory 06:57:55 INFO - Expected file size: 58125549 06:57:55 INFO - Obtained file size: 58125549 06:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.talos.tests.zip 06:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.talos.tests.zip into memory 06:58:07 INFO - Expected file size: 14404171 06:58:07 INFO - Obtained file size: 14404171 06:58:07 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:07 INFO - trying https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 06:58:07 INFO - Downloading https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:58:09 INFO - Downloaded 62554570 bytes. 06:58:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 06:58:09 INFO - mkdir: /builds/slave/test/properties 06:58:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:09 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:09 INFO - Contents: 06:58:09 INFO - build_url:https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 06:58:09 INFO - Running post-action listener: _resource_record_post_action 06:58:09 INFO - Running post-action listener: set_extra_try_arguments 06:58:09 INFO - [mozharness: 2017-03-24 13:58:09.756588Z] Finished download-and-extract step (success) 06:58:09 INFO - [mozharness: 2017-03-24 13:58:09.756710Z] Running populate-webroot step. 06:58:09 INFO - Running pre-action listener: _resource_record_pre_action 06:58:09 INFO - Running main action method: populate_webroot 06:58:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:09 INFO - '--tppagecycles', 06:58:09 INFO - '7'], 06:58:09 INFO - 'tests': ['tsvgm']}}, 06:58:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['damp', 'tps']}, 06:58:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'tests': ['damp', 'tps']}, 06:58:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['dromaeo_dom']}, 06:58:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['basic_compositor_video']}, 06:58:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:58:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['a11yr', 06:58:09 INFO - 'ts_paint', 06:58:09 INFO - 'tpaint', 06:58:09 INFO - 'sessionrestore', 06:58:09 INFO - 'sessionrestore_no_auto_restore', 06:58:09 INFO - 'tabpaint']}, 06:58:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['tsvgx', 06:58:09 INFO - 'tsvgr_opacity', 06:58:09 INFO - 'tart', 06:58:09 INFO - 'tscrollx', 06:58:09 INFO - 'cart', 06:58:09 INFO - 'tsvg_static']}, 06:58:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:09 INFO - 'tsvgr_opacity', 06:58:09 INFO - 'tart', 06:58:09 INFO - 'tscrollx', 06:58:09 INFO - 'cart', 06:58:09 INFO - 'tsvg_static']}, 06:58:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'talos_options': ['--disable-e10s'], 06:58:09 INFO - 'tests': ['tp5o']}, 06:58:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:58:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'talos_options': ['--disable-e10s', 06:58:09 INFO - '--xperf_path', 06:58:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:09 INFO - 'tests': ['tp5n']}, 06:58:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:58:09 INFO - 'talos_options': ['--xperf_path', 06:58:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:09 INFO - 'tests': ['tp5n']}}, 06:58:09 INFO - 'talos.zip': {'path': '', 06:58:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:09 INFO - Running post-action listener: _resource_record_post_action 06:58:09 INFO - [mozharness: 2017-03-24 13:58:09.770253Z] Finished populate-webroot step (success) 06:58:09 INFO - [mozharness: 2017-03-24 13:58:09.770341Z] Running create-virtualenv step. 06:58:09 INFO - Running pre-action listener: _resource_record_pre_action 06:58:09 INFO - Running main action method: create_virtualenv 06:58:09 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:09 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 06:58:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:09 INFO - Using real prefix '/usr' 06:58:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:10 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:12 INFO - Installing pip.................done. 06:58:12 INFO - Return code: 0 06:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:58:12 INFO - Reading from file tmpfile_stdout 06:58:12 INFO - Output received: 06:58:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:58:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:12 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 06:58:12 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 06:58:12 INFO - Using env: {'DISPLAY': ':0', 06:58:12 INFO - 'HOME': '/home/cltbld', 06:58:12 INFO - 'LANG': 'en_US.UTF-8', 06:58:12 INFO - 'LANGUAGE': 'en_US:en', 06:58:12 INFO - 'LOGNAME': 'cltbld', 06:58:12 INFO - 'MAIL': '/var/mail/cltbld', 06:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:12 INFO - 'MOZ_NO_REMOTE': '1', 06:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:12 INFO - 'NO_EM_RESTART': '1', 06:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:12 INFO - 'PWD': '/builds/slave/test', 06:58:12 INFO - 'SHELL': '/bin/bash', 06:58:12 INFO - 'SHLVL': '1', 06:58:12 INFO - 'TERM': 'linux', 06:58:12 INFO - 'TMOUT': '86400', 06:58:12 INFO - 'USER': 'cltbld', 06:58:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:12 INFO - '_': '/tools/buildbot/bin/python'} 06:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:12 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 06:58:12 INFO - Cleaning up... 06:58:12 INFO - Return code: 0 06:58:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:58:12 INFO - Using env: {'DISPLAY': ':0', 06:58:12 INFO - 'HOME': '/home/cltbld', 06:58:12 INFO - 'LANG': 'en_US.UTF-8', 06:58:12 INFO - 'LANGUAGE': 'en_US:en', 06:58:12 INFO - 'LOGNAME': 'cltbld', 06:58:12 INFO - 'MAIL': '/var/mail/cltbld', 06:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:12 INFO - 'MOZ_NO_REMOTE': '1', 06:58:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:12 INFO - 'NO_EM_RESTART': '1', 06:58:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:12 INFO - 'PWD': '/builds/slave/test', 06:58:12 INFO - 'SHELL': '/bin/bash', 06:58:12 INFO - 'SHLVL': '1', 06:58:12 INFO - 'TERM': 'linux', 06:58:12 INFO - 'TMOUT': '86400', 06:58:12 INFO - 'USER': 'cltbld', 06:58:12 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:12 INFO - '_': '/tools/buildbot/bin/python'} 06:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:13 INFO - Downloading/unpacking psutil>=3.1.1 06:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:15 INFO - Installing collected packages: psutil 06:58:15 INFO - Running setup.py install for psutil 06:58:15 INFO - building 'psutil._psutil_linux' extension 06:58:15 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 06:58:15 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 06:58:15 INFO - building 'psutil._psutil_posix' extension 06:58:15 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 06:58:15 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 06:58:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:15 INFO - Successfully installed psutil 06:58:15 INFO - Cleaning up... 06:58:15 INFO - Return code: 0 06:58:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:58:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:58:15 INFO - Using env: {'DISPLAY': ':0', 06:58:15 INFO - 'HOME': '/home/cltbld', 06:58:15 INFO - 'LANG': 'en_US.UTF-8', 06:58:15 INFO - 'LANGUAGE': 'en_US:en', 06:58:15 INFO - 'LOGNAME': 'cltbld', 06:58:15 INFO - 'MAIL': '/var/mail/cltbld', 06:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:15 INFO - 'MOZ_NO_REMOTE': '1', 06:58:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:15 INFO - 'NO_EM_RESTART': '1', 06:58:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:15 INFO - 'PWD': '/builds/slave/test', 06:58:15 INFO - 'SHELL': '/bin/bash', 06:58:15 INFO - 'SHLVL': '1', 06:58:15 INFO - 'TERM': 'linux', 06:58:15 INFO - 'TMOUT': '86400', 06:58:15 INFO - 'USER': 'cltbld', 06:58:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:15 INFO - '_': '/tools/buildbot/bin/python'} 06:58:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:58:15 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 06:58:15 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 06:58:15 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 06:58:15 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 06:58:15 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 06:58:15 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 06:58:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:58:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:58:17 INFO - Installing collected packages: mozsystemmonitor 06:58:17 INFO - Running setup.py install for mozsystemmonitor 06:58:18 INFO - Successfully installed mozsystemmonitor 06:58:18 INFO - Cleaning up... 06:58:18 INFO - Return code: 0 06:58:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:58:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:18 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:58:18 INFO - Using env: {'DISPLAY': ':0', 06:58:18 INFO - 'HOME': '/home/cltbld', 06:58:18 INFO - 'LANG': 'en_US.UTF-8', 06:58:18 INFO - 'LANGUAGE': 'en_US:en', 06:58:18 INFO - 'LOGNAME': 'cltbld', 06:58:18 INFO - 'MAIL': '/var/mail/cltbld', 06:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:18 INFO - 'MOZ_NO_REMOTE': '1', 06:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:18 INFO - 'NO_EM_RESTART': '1', 06:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:18 INFO - 'PWD': '/builds/slave/test', 06:58:18 INFO - 'SHELL': '/bin/bash', 06:58:18 INFO - 'SHLVL': '1', 06:58:18 INFO - 'TERM': 'linux', 06:58:18 INFO - 'TMOUT': '86400', 06:58:18 INFO - 'USER': 'cltbld', 06:58:18 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:18 INFO - '_': '/tools/buildbot/bin/python'} 06:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:18 INFO - Downloading/unpacking jsonschema==2.5.1 06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:20 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:20 INFO - warning: no files found matching '*.txt' 06:58:20 INFO - no previously-included directories found matching 'build' 06:58:20 INFO - no previously-included directories found matching 'dist' 06:58:20 INFO - no previously-included directories found matching '.git*' 06:58:20 INFO - Installing collected packages: jsonschema, functools32 06:58:20 INFO - Running setup.py install for functools32 06:58:20 INFO - warning: no files found matching '*.txt' 06:58:20 INFO - no previously-included directories found matching 'build' 06:58:20 INFO - no previously-included directories found matching 'dist' 06:58:20 INFO - no previously-included directories found matching '.git*' 06:58:20 INFO - Successfully installed jsonschema functools32 06:58:20 INFO - Cleaning up... 06:58:20 INFO - Return code: 0 06:58:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:20 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:20 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:58:20 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 functools32==3.2.3-2 06:58:20 INFO - Using env: {'DISPLAY': ':0', 06:58:20 INFO - 'HOME': '/home/cltbld', 06:58:20 INFO - 'LANG': 'en_US.UTF-8', 06:58:20 INFO - 'LANGUAGE': 'en_US:en', 06:58:20 INFO - 'LOGNAME': 'cltbld', 06:58:20 INFO - 'MAIL': '/var/mail/cltbld', 06:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:20 INFO - 'MOZ_NO_REMOTE': '1', 06:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:20 INFO - 'NO_EM_RESTART': '1', 06:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:20 INFO - 'PWD': '/builds/slave/test', 06:58:20 INFO - 'SHELL': '/bin/bash', 06:58:20 INFO - 'SHLVL': '1', 06:58:20 INFO - 'TERM': 'linux', 06:58:20 INFO - 'TMOUT': '86400', 06:58:20 INFO - 'USER': 'cltbld', 06:58:20 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:20 INFO - '_': '/tools/buildbot/bin/python'} 06:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:58:21 INFO - Cleaning up... 06:58:21 INFO - Return code: 0 06:58:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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', '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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58: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 blobuploader==1.2.4 06:58:21 INFO - Using env: {'DISPLAY': ':0', 06:58:21 INFO - 'HOME': '/home/cltbld', 06:58:21 INFO - 'LANG': 'en_US.UTF-8', 06:58:21 INFO - 'LANGUAGE': 'en_US:en', 06:58:21 INFO - 'LOGNAME': 'cltbld', 06:58:21 INFO - 'MAIL': '/var/mail/cltbld', 06:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:21 INFO - 'MOZ_NO_REMOTE': '1', 06:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:21 INFO - 'NO_EM_RESTART': '1', 06:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:21 INFO - 'PWD': '/builds/slave/test', 06:58:21 INFO - 'SHELL': '/bin/bash', 06:58:21 INFO - 'SHLVL': '1', 06:58:21 INFO - 'TERM': 'linux', 06:58:21 INFO - 'TMOUT': '86400', 06:58:21 INFO - 'USER': 'cltbld', 06:58:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:21 INFO - '_': '/tools/buildbot/bin/python'} 06:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:21 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:23 INFO - Downloading docopt-0.6.1.tar.gz 06:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:24 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:24 INFO - Running setup.py install for blobuploader 06:58:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:24 INFO - Running setup.py install for requests 06:58:24 INFO - Running setup.py install for docopt 06:58:24 INFO - Successfully installed blobuploader requests docopt 06:58:24 INFO - Cleaning up... 06:58:24 INFO - Return code: 0 06:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:24 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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:24 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 06:58:24 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 06:58:24 INFO - Using env: {'DISPLAY': ':0', 06:58:24 INFO - 'HOME': '/home/cltbld', 06:58:24 INFO - 'LANG': 'en_US.UTF-8', 06:58:24 INFO - 'LANGUAGE': 'en_US:en', 06:58:24 INFO - 'LOGNAME': 'cltbld', 06:58:24 INFO - 'MAIL': '/var/mail/cltbld', 06:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:24 INFO - 'MOZ_NO_REMOTE': '1', 06:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:24 INFO - 'NO_EM_RESTART': '1', 06:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:24 INFO - 'PWD': '/builds/slave/test', 06:58:24 INFO - 'SHELL': '/bin/bash', 06:58:24 INFO - 'SHLVL': '1', 06:58:24 INFO - 'TERM': 'linux', 06:58:24 INFO - 'TMOUT': '86400', 06:58:24 INFO - 'USER': 'cltbld', 06:58:24 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:24 INFO - '_': '/tools/buildbot/bin/python'} 06:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:24 INFO - Running setup.py (path:/tmp/pip-pP0xpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:24 INFO - Running setup.py (path:/tmp/pip-EmVF83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:25 INFO - Running setup.py (path:/tmp/pip-4XPWQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:25 INFO - Running setup.py (path:/tmp/pip-KgLgv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:25 INFO - Running setup.py (path:/tmp/pip-DcLwPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:25 INFO - Running setup.py (path:/tmp/pip-bb_56V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:25 INFO - Running setup.py (path:/tmp/pip-xEbveF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:25 INFO - Running setup.py (path:/tmp/pip-IREc8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:25 INFO - Running setup.py (path:/tmp/pip-kIqoyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:25 INFO - Running setup.py (path:/tmp/pip-ys5mEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:25 INFO - Running setup.py (path:/tmp/pip-56Je3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:25 INFO - Running setup.py (path:/tmp/pip-zUpWFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:25 INFO - Running setup.py (path:/tmp/pip-ASpfMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:25 INFO - Running setup.py (path:/tmp/pip-rBu3UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:25 INFO - Running setup.py (path:/tmp/pip-0znzWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:25 INFO - Running setup.py (path:/tmp/pip-CcAJ4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:26 INFO - Running setup.py (path:/tmp/pip-UZVBUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:26 INFO - Running setup.py install for manifestparser 06:58:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozcrash 06:58:26 INFO - Running setup.py install for mozdebug 06:58:26 INFO - Running setup.py install for mozdevice 06:58:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozfile 06:58:26 INFO - Running setup.py install for mozhttpd 06:58:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozinfo 06:58:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozInstall 06:58:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:26 INFO - Running setup.py install for mozleak 06:58:26 INFO - Running setup.py install for mozlog 06:58:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Running setup.py install for moznetwork 06:58:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Running setup.py install for mozprocess 06:58:27 INFO - Running setup.py install for mozprofile 06:58:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Running setup.py install for mozrunner 06:58:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Running setup.py install for mozscreenshot 06:58:27 INFO - Running setup.py install for moztest 06:58:27 INFO - Running setup.py install for mozversion 06:58:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:27 INFO - Cleaning up... 06:58:27 INFO - Return code: 0 06:58:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:27 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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:27 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 06:58:27 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 06:58:27 INFO - Using env: {'DISPLAY': ':0', 06:58:27 INFO - 'HOME': '/home/cltbld', 06:58:27 INFO - 'LANG': 'en_US.UTF-8', 06:58:27 INFO - 'LANGUAGE': 'en_US:en', 06:58:27 INFO - 'LOGNAME': 'cltbld', 06:58:27 INFO - 'MAIL': '/var/mail/cltbld', 06:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:27 INFO - 'MOZ_NO_REMOTE': '1', 06:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:27 INFO - 'NO_EM_RESTART': '1', 06:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:27 INFO - 'PWD': '/builds/slave/test', 06:58:27 INFO - 'SHELL': '/bin/bash', 06:58:27 INFO - 'SHLVL': '1', 06:58:27 INFO - 'TERM': 'linux', 06:58:27 INFO - 'TMOUT': '86400', 06:58:27 INFO - 'USER': 'cltbld', 06:58:27 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:27 INFO - '_': '/tools/buildbot/bin/python'} 06:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:28 INFO - Running setup.py (path:/tmp/pip-3HVGvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:28 INFO - Running setup.py (path:/tmp/pip-fPR7au-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:28 INFO - Running setup.py (path:/tmp/pip-Uws9tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:28 INFO - Running setup.py (path:/tmp/pip-tM7Ouo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:28 INFO - Running setup.py (path:/tmp/pip-qZ5qsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:28 INFO - Running setup.py (path:/tmp/pip-qocE2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:28 INFO - Running setup.py (path:/tmp/pip-8gmiUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:28 INFO - Running setup.py (path:/tmp/pip-F_GLEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:28 INFO - Running setup.py (path:/tmp/pip-l7SgOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:28 INFO - Running setup.py (path:/tmp/pip-BfZHVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:28 INFO - Running setup.py (path:/tmp/pip-xHinEA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:28 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:28 INFO - Running setup.py (path:/tmp/pip-AG5e2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 06:58:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:28 INFO - Running setup.py (path:/tmp/pip-QuF8T6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:29 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)) 06:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:29 INFO - Running setup.py (path:/tmp/pip-kaMc3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 06:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:29 INFO - Running setup.py (path:/tmp/pip-Ib3VXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:29 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)) 06:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:29 INFO - Running setup.py (path:/tmp/pip-51oFiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 06:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:29 INFO - Running setup.py (path:/tmp/pip-MRwoWC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:29 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)) 06:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:29 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)) 06:58:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:29 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:31 INFO - Downloading blessings-1.6.tar.gz 06:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:31 INFO - Installing collected packages: blessings 06:58:31 INFO - Running setup.py install for blessings 06:58:31 INFO - Successfully installed blessings 06:58:31 INFO - Cleaning up... 06:58:31 INFO - Return code: 0 06:58:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:31 INFO - Reading from file tmpfile_stdout 06:58:31 INFO - Current package versions: 06:58:31 INFO - argparse == 1.2.1 06:58:31 INFO - blessings == 1.6 06:58:31 INFO - blobuploader == 1.2.4 06:58:31 INFO - docopt == 0.6.1 06:58:31 INFO - functools32 == 3.2.3-2 06:58:31 INFO - jsonschema == 2.5.1 06:58:31 INFO - manifestparser == 1.1 06:58:31 INFO - mozInstall == 1.12 06:58:31 INFO - mozcrash == 1.0 06:58:31 INFO - mozdebug == 0.1 06:58:31 INFO - mozdevice == 0.49 06:58:31 INFO - mozfile == 1.2 06:58:31 INFO - mozhttpd == 0.7 06:58:31 INFO - mozinfo == 0.9 06:58:31 INFO - mozleak == 0.1 06:58:31 INFO - mozlog == 3.4 06:58:31 INFO - moznetwork == 0.27 06:58:31 INFO - mozprocess == 0.25 06:58:31 INFO - mozprofile == 0.28 06:58:31 INFO - mozrunner == 6.13 06:58:31 INFO - mozscreenshot == 0.1 06:58:31 INFO - mozsystemmonitor == 0.3 06:58:31 INFO - moztest == 0.8 06:58:31 INFO - mozversion == 1.4 06:58:31 INFO - psutil == 3.1.1 06:58:31 INFO - requests == 1.2.3 06:58:31 INFO - wsgiref == 0.1.2 06:58:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:31 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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:31 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 06:58:31 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 06:58:31 INFO - Using env: {'DISPLAY': ':0', 06:58:31 INFO - 'HOME': '/home/cltbld', 06:58:31 INFO - 'LANG': 'en_US.UTF-8', 06:58:31 INFO - 'LANGUAGE': 'en_US:en', 06:58:31 INFO - 'LOGNAME': 'cltbld', 06:58:31 INFO - 'MAIL': '/var/mail/cltbld', 06:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:31 INFO - 'MOZ_NO_REMOTE': '1', 06:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:31 INFO - 'NO_EM_RESTART': '1', 06:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:31 INFO - 'PWD': '/builds/slave/test', 06:58:31 INFO - 'SHELL': '/bin/bash', 06:58:31 INFO - 'SHLVL': '1', 06:58:31 INFO - 'TERM': 'linux', 06:58:31 INFO - 'TMOUT': '86400', 06:58:31 INFO - 'USER': 'cltbld', 06:58:31 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:31 INFO - '_': '/tools/buildbot/bin/python'} 06:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 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)) 06:58:32 INFO - Cleaning up... 06:58:32 INFO - Return code: 0 06:58:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:32 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 0x1c9c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d94a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f39b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, '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': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', '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 06:58:32 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 06:58:32 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 06:58:32 INFO - Using env: {'DISPLAY': ':0', 06:58:32 INFO - 'HOME': '/home/cltbld', 06:58:32 INFO - 'LANG': 'en_US.UTF-8', 06:58:32 INFO - 'LANGUAGE': 'en_US:en', 06:58:32 INFO - 'LOGNAME': 'cltbld', 06:58:32 INFO - 'MAIL': '/var/mail/cltbld', 06:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:32 INFO - 'MOZ_NO_REMOTE': '1', 06:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:32 INFO - 'NO_EM_RESTART': '1', 06:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:32 INFO - 'PWD': '/builds/slave/test', 06:58:32 INFO - 'SHELL': '/bin/bash', 06:58:32 INFO - 'SHLVL': '1', 06:58:32 INFO - 'TERM': 'linux', 06:58:32 INFO - 'TMOUT': '86400', 06:58:32 INFO - 'USER': 'cltbld', 06:58:32 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:32 INFO - '_': '/tools/buildbot/bin/python'} 06:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:58:32 INFO - Cleaning up... 06:58:32 INFO - Return code: 0 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - Running post-action listener: _start_resource_monitoring 06:58:32 INFO - Starting resource monitoring. 06:58:32 INFO - [mozharness: 2017-03-24 13:58:32.287656Z] Finished create-virtualenv step (success) 06:58:32 INFO - [mozharness: 2017-03-24 13:58:32.288172Z] Running install step. 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: install 06:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:32 INFO - Reading from file tmpfile_stdout 06:58:32 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:32 INFO - Reading from file tmpfile_stdout 06:58:32 INFO - Output received: 06:58:32 INFO - Usage: mozinstall [options] installer 06:58:32 INFO - Options: 06:58:32 INFO - -h, --help show this help message and exit 06:58:32 INFO - -d DEST, --destination=DEST 06:58:32 INFO - Directory to install application into. [default: 06:58:32 INFO - "/builds/slave/test"] 06:58:32 INFO - --app=APP Application being installed. [default: firefox] 06:58:32 INFO - mkdir: /builds/slave/test/build/application 06:58:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:58:48 INFO - Reading from file tmpfile_stdout 06:58:48 INFO - Output received: 06:58:48 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:48 INFO - Running post-action listener: _resource_record_post_action 06:58:48 INFO - [mozharness: 2017-03-24 13:58:48.262790Z] Finished install step (success) 06:58:48 INFO - [mozharness: 2017-03-24 13:58:48.263066Z] Running run-tests step. 06:58:48 INFO - Running pre-action listener: _resource_record_pre_action 06:58:48 INFO - Running main action method: run_tests 06:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:48 INFO - Python 2.7.3 06:58:48 INFO - Return code: 0 06:58:48 INFO - grabbing minidump binary from tooltool 06:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:48 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f37290>, '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 0x1f37b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f38040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:48 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 06:58:48 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 06:58:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:58:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:48 INFO - Return code: 0 06:58:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:48 INFO - ENV: RUST_BACKTRACE is now 1 06:58:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 06:58:48 INFO - Using env: {'DISPLAY': ':0', 06:58:48 INFO - 'HOME': '/home/cltbld', 06:58:48 INFO - 'LANG': 'en_US.UTF-8', 06:58:48 INFO - 'LANGUAGE': 'en_US:en', 06:58:48 INFO - 'LOGNAME': 'cltbld', 06:58:48 INFO - 'MAIL': '/var/mail/cltbld', 06:58:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:48 INFO - 'MOZ_NO_REMOTE': '1', 06:58:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:48 INFO - 'NO_EM_RESTART': '1', 06:58:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:48 INFO - 'PWD': '/builds/slave/test', 06:58:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:48 INFO - 'RUST_BACKTRACE': '1', 06:58:48 INFO - 'SHELL': '/bin/bash', 06:58:48 INFO - 'SHLVL': '1', 06:58:48 INFO - 'TERM': 'linux', 06:58:48 INFO - 'TMOUT': '86400', 06:58:48 INFO - 'USER': 'cltbld', 06:58:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147', 06:58:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:48 INFO - '_': '/tools/buildbot/bin/python'} 06:58:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 06:58:48 INFO - mozversion application_buildid: 20170324132456 06:58:48 INFO - mozversion application_changeset: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd 06:58:48 INFO - mozversion application_display_name: Nightly 06:58:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:48 INFO - mozversion application_name: Firefox 06:58:48 INFO - mozversion application_remotingname: firefox 06:58:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:58:48 INFO - mozversion application_vendor: Mozilla 06:58:48 INFO - mozversion application_version: 55.0a1 06:58:48 INFO - mozversion platform_buildid: 20170324132456 06:58:48 INFO - mozversion platform_changeset: 4c987b7ed54a630a7de76adcc2eb00dab49d5dfd 06:58:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:58:48 INFO - mozversion platform_version: 55.0a1 06:58:48 INFO - using testdate: 1490363928 06:58:48 INFO - actual date: 1490363928 06:58:48 INFO - starting webserver on 'localhost:40549' 06:58:48 INFO - SUITE-START | Running 2 tests 06:58:48 INFO - TEST-START | dromaeo_css 06:58:48 INFO - operating with platform_type : linux_ 06:58:48 INFO - Initialising browser for dromaeo_css test... 06:58:48 INFO - TEST-INFO | started process 26623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0SMu5/profile http://localhost:40549/getInfo.html) 06:58:52 INFO - PID 26623 | __metrics Screen width/height:1600/1200 06:58:52 INFO - PID 26623 | colorDepth:24 06:58:52 INFO - PID 26623 | Browser inner width/height: 1024/697 06:58:52 INFO - PID 26623 | __metrics 06:58:53 ERROR - PID 26623 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 06:58:54 INFO - TEST-INFO | 26623: exit 0 06:58:54 INFO - Browser initialized. 06:58:54 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:54 INFO - TEST-INFO | started process 26753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0SMu5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:06 INFO - PID 26753 | RSS: Main: 155717632 06:59:06 INFO - PID 26753 | 07:02:11 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40549/tests/dromaeo/cssquery-ext.html) 07:02:13 INFO - PID 26753 | RSS: Main: 165449728 07:02:13 INFO - PID 26753 | 07:03:55 INFO - PID 26753 | ************************* 07:03:55 INFO - PID 26753 | A coding exception was thrown and uncaught in a Task. 07:03:55 INFO - PID 26753 | 07:03:55 ERROR - PID 26753 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:03:55 INFO - PID 26753 | Full stack: 07:03:55 INFO - PID 26753 | ************************* 07:05:16 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-ext.html (next: http://localhost:40549/tests/dromaeo/cssquery-jquery.html) 07:05:16 INFO - PID 26753 | RSS: Main: 162504704 07:05:16 INFO - PID 26753 | 07:08:19 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40549/tests/dromaeo/cssquery-mootools.html) 07:08:19 INFO - PID 26753 | RSS: Main: 169701376 07:08:19 INFO - PID 26753 | 07:11:21 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40549/tests/dromaeo/cssquery-prototype.html) 07:11:22 INFO - PID 26753 | RSS: Main: 161619968 07:11:22 INFO - PID 26753 | 07:14:25 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40549/tests/dromaeo/cssquery-yui.html) 07:14:25 INFO - PID 26753 | RSS: Main: 169230336 07:14:25 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | Cycle 1(1): loaded http://localhost:40549/tests/dromaeo/cssquery-yui.html (next: http://localhost:40549/tests/dromaeo/cssquery-dojo.html) 07:17:29 INFO - PID 26753 | RSS: Main: 161898496 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | __start_tp_report 07:17:29 INFO - PID 26753 | _x_x_mozilla_page_load 07:17:29 INFO - PID 26753 | _x_x_mozilla_page_load_details 07:17:29 INFO - PID 26753 | |i|pagename|runs| 07:17:29 INFO - PID 26753 | |0;dojo.html;2716.0629582793936;2728.4406696627193;2741.1091395296535;2758.7517123458883;2763.8894444222233;5202.141646628302;5264.763085661145;5293.682379057259;5299.178627312763;5309.575233981282;5216.29580006699;5239.764210610522;5275.973620131904;5333.253344531759;5342.759575819087;4793.137235297654;4824.0834241494;4840.322354870321;4852;4870.634702397317;4834.927476087862;4847.369841920546;4902.313676085333;4906.435759887623;4947.084789313971;4727.409073865767;4749.907521270093;4752.310914917352;4821.54195351441;4824.565789079;4776.713397196179;4791.688540244873;4809.879753006167;4837.830675926326;4843.782029808667;4683.437987441494;4747.074320507502;4754.405699287589;4767.737774422405;4796.976015119937;5138.511841375101;5145.845624631267;5245.396779370383;5266.789328426858;5315.362156541201;5561.972190139064;5635.21107045014;5638.210650508932;5644.153376993443;5701.116326969326;5714.51426628737;5719.71401429931;5736.110902810029;5738.741756620962;5750.769969201227;5179.249008893765;5306.151015837448;5309.070912590281;5323.707196104213;5374.167004114369;5644.435556444405;5713.914291285634;5720.599558030898;5733;5736.225609542742;5441.156620723794;5448.591355648263;5464.043792336325;5465.9726701367035;5492.752826122834;5511.283533140746;5533.833984980457;5537.833864984057;5557.472040156179;5581.023320918823;5606.103023516218;5606.327240731139;5612.691301978349;5612.859678507988;5633.464820842013;5605.383407825136;5619.8595035124445;5621.016322143609;5628.915566266509;5632.577556683265;4766.833160839354;4770.76146192689;4775.856724298276;4782.689125206851;4787.569118779257;4097.426360309559;4099.1801639672185;4107.712460127822;4109.56849530795;4145.3781932709735;4899.608031357483;4908.312836202935;4913;4919.458859525449;4939.629527785431;5597.776088956396;5658.321001479849;5704.34400043992;5716.5140963017775;5729.312482502127;4923.08922849274;4925.113479573711;4932.087563800708;4942.950570494321;4996.1007018736245;5111.361079865017;5122.846314610568;5132.923006154911;5138;5170.250313704567;5231.581473482189;5290.127129023822;5300.178472336794;5341.75962081715;5350.30446042012;5728.914066289092;5738.081906895044;5748.166515855261;5788.27646544182;5798.884022319446;5321.893562128813;5328.547073498796;5333.813316533902;5336.09286421317;5341.75962081715;5452.809151679831;5567.66594004361;5594.832155035356;5626.690532020778;5680.943190568207;5606.299212598426;5626.465485778845;5638.605297629127;5645.887082258249;5667.4615911488345;5430.212619170277;5460.3720572133125;5471.398146203994;5475.4524547544925;5490.176473529003;5509.449055094458;5535.280413546213;5578.940001399721;5595.832125036255;5614.831555053355;5409.323834520685;5425.728713564385;5464.508194262536;5478.068728316275;5483.643563168382;5429.7556609953435;5597.692126933058;5606.719664016701;5610.887782244414;5669.376368599368;5267.209918512254;5394.595405344537;5409.486098820606;5429.077056900257;5475.315585551806 07:17:29 INFO - PID 26753 | |1;ext.html;685.2941470285605;694.9298080955328;1057.9312344697594;1069.4385447639993;1169.2341516306822;31837;32788.7537993921;32850.50724239135;32887;33017.66982330176;32451.350972980526;32848;32873.83563082187;32904.67095329046;32950.34099318018;6972.721091156348;7108.715651373939;7120.679569419362;7335.339819416252;7509.249075092502;7416.184219735825;7623.352015078725;7625.6568454419685;7691.384689224877;7714.459987800856;7682.423818213629;7698.6150692465435;7749;7754.418418618598;7772.961135194316;7666;7679.116901556336;7687.500312479727;7703.037120359955;7706.6917323307;7502.887456688154;7556.282153195492;7559.28186822251;7561;7562.9789978352765;34912;35074.473882891776;35386;35403;35501.46747798785;2709.9322516937036;2740.6985231624503;2741.0543362539893;2770.293575138347;2782.38787466757;23781;24132.63801042986;24164.879175604186;24218.63672044921;24390.756092439202;2921.26790382379;2974.3605124898036;3010.307629245264;3013.8493075346146;3045.33002739397;137151.31424342914;138175.92736108968;139975;140034.2998285012;140109;33661.326773464396;34199.14502137417;38626.42060369097;44785;45431.772841135586;46902.53097468981;47080.5291947083;47472;47585.76207118942;47617;12414.503419863104;12588.559400420942;12593.93703031479;12597.874021259853;12626.936865315798;9827.557759900821;9853.310268281151;9854.655087071918;9855.162311203485;9875.654352097643;13446.46214151423;13475.730485390237;13511.189328640314;13618.591442256748;13673.931630341785;5556.527695145958;5651.547876169979;5689.971550142222;5742.569307301969;5797.188393624896;854.7905763088083;875.4834647557972;883.88067610873;888.6401007591936;917.7751450894574;20312.69530957037;21261.893690531448;21419.57160856774;21484;21607.89196054041;975;976.6679329028165;996.267743208741;1004.3421558878946;1004.8693669822876;10481.790364192673;11113.277636953571;11153.275037122561;11194.977356113966;11361.488733007034;235555;237742;238832;239255;239756;42199.7890010548;42841.143177136284;42917.78541107337;42945.785271073444;43029;1207.7342984543386;1247.4511215065343;1252.8809763072493;1255.8681338459512;1260.3635164241998;19792.307269245506;19900.303489377802;20807.375778726662;20959.26642567503;21015.8949205253;30533.694663053084;30541.694583053886;30881.073567793002;30884.53673194859;30929.536056958714;210572;211541;211698;211787;212012;28628.85685571559;28697.71302287034;28707;28793.56809647815;29873.850630746707;33702.49446258259;34718.82640586781;36725.81637091797;37672;37775.62224377831;27489.31276718098;28259.92585237357;28724.712752872205;29118.56322155127;29144.854275728485;28216.576751348337;28609.14172574826;28815;29116.563251551666;29219.561706573993;29843.701562984093;29927.55108673328;29928;31298.687013129576;31358.529622056143;25815.741842581334;26267.080652177083;26290.868545657147;26569.468610628064;26665.466690666464;20813.687794682788;22346.553068938207;22524;22814.657780133643;22937.197198097987 07:17:29 INFO - PID 26753 | |2;jquery.html;415.47442485256136;419.5489848412955;423.3874744749808;437.6455071392173;446.72526396266284;16112.436064737707;16296.511104666864;16986.83013169868;17032.31870725171;17689.82310176898;16603.252853621587;16885.57786055349;17006.914965425185;17285.913570432163;17558.29766809329;5517.751701173457;5524.806631767879;5646.971765141168;5651.2370829937845;5684.403137670547;5595.440455954393;5658.660480371191;5659.4340565943485;5680;5687.345955215141;5443.972780136094;5630.268065151525;5648.6893220872835;5649.661020338793;5676.205331253628;5568.443155684439;5612.214289999403;5612.7754889804355;5655.123455864327;5674.120511320752;4944.159492886218;5038.193888977746;5048.469910659402;5093.414257360414;5115.641905066647;22000.779992200034;22161.778382216133;22313.665295020586;22367.217147399762;22392.552148957093;1534.3325653340833;1574.480421460915;1586.8730501559849;1592.3710134496926;1611.8871678982475;13634.590962271148;13901;13964;14635.70728585433;14752.188629625367;1734.5663584103975;1757.2443849144863;1791.3998810398532;1793.515750747304;1809.3848091648772;85271;87105.12894871098;87378.56310718469;88100.5594972021;89148.10851891463;10884.727881803019;11039.558417663204;11121;11164;11267.661970140745;15238.771418428732;15249.085054896741;15268.16025118607;15281.847181528265;15339.463118790789;7036.788896333118;7365.116186057708;7451.44114191427;7493.85012299751;7595.354394876497;6861.245263021064;6884.827879303058;7081.681324340417;7103.147622285359;7150.821229469305;6865.009147347213;6931.445484361239;6986.510944233854;7056.682449289794;7082.645867706594;2081.5004398944448;2085.4994801247894;2097.1820989813987;2101.107029512451;2228.8662680238913;821.6507984106851;842.1914961636775;851.1743608699552;852.2500199824115;881.4358810361374;16259.349626015064;16645;16983.320667173175;17076.316947322215;17729.46811595654;853.4196746212511;853.6457370191301;870.3602851903846;871.808202195516;873.0701802580231;9475.763105922408;9511;9535.952320238493;9590.856137157949;9756.414615122972;287102;414059;420406;422005;422617;82213.52922439884;85956;85965;86460.56769716111;86858.56570717106;1051.5530899367739;1073.7100982734619;1080.1358912869673;1082.7401423658266;1084.6800193942806;14540.272986350428;16342.182890855647;17977.550561236072;18022.63954720872;18113.184906679493;42816;42961.35557966695;43670.344944825214;43862.56137438585;43863.56136438723;47796.35258358646;48583.113350932545;56549.71725141348;57791;58067;7827.84344313122;7871.134175240604;7982.6429506982795;8136.267735903797;8241.464304820167;11531;12198.743232502016;12199.390030498262;12244.87755122473;12343.629691109281;10381.63664271777;10562.15502759762;10598.523066461874;10646.946765266124;11017.394043327695;9588.280878934247;9638.759031024281;9739.41563506192;9837.950810245902;9848.803023939625;10686.839697404701;10817.729556761144;10824.891751082389;11209.327440353605;11314.151438642299;8143.75568732939;8234.794130146794;8322;8408.83182336362;8467.872981905153;9836.311458197857;9938.900610994087;10024.448655324028;10132.088112069949;10368.274220804471 07:17:29 INFO - PID 26753 | |3;mootools.html;1265.8923991460726;1320.6038188543434;1350.5745690107622;1352.7429788340214;1355.3900744664898;9707.61169553218;9873.901260987388;10218.74453138672;10225.335353202046;10233.795324093522;10002.049600327939;10164.593416263358;10171.186305095593;10477.633282835102;10487.73780655482;2271.6138256496392;2314.9652755208685;2320.872352020638;2328.1153161798493;2328.9767102329015;2155.5150091229507;2170.5441857209926;2176.923807666732;2179.683945827854;2307.2501437033034;2098.98950505248;2134.9893250533723;2271.602469567819;2276.1350686739015;2292.197730794217;2125.054350813873;2151.225558798831;2160.114353115223;2168.024389024937;2172.6632371982446;1802.9549261268573;1868.4768264885854;2176.3470958712323;2188.113813905371;2260.16373941641;9776.120149186536;9875.308728389016;9955.75110622233;9966;9978.800423991479;5502.394736578973;5754.827355179351;5755.7625110601;5769.769209231626;5779.826605201809;3239.5626590410466;3285.1458620758535;3327.218103745618;3356.9160770980675;3419.247765491588;937.8452555328431;943.8820147481565;955.7849483866144;982.8230918434679;1021.1167340250704;15040.548783536402;15047.172405517693;15130.243487825564;15132.319045642973;15146.621334466727;4792.7124372537755;4937.925931111036;4940.1601727706375;4975.577075948512;5070.138076527;11036.061934735477;11043.72390690223;11078.11375090007;11085.556577736961;11107.166962477846;5595.692236926927;5606.523445507178;5620.57845661577;5635.605507614428;5673.262475878192;4977.0792403405485;5083.974580127076;5116.513931176532;5193.246979187997;5201.427842937273;3730.7948062856804;3832.352088601928;3858.054776579756;3876.341022026262;3893.53277606689;1101.515333253366;1112.071420364005;1131.4851742457163;1133.4106264742288;1150.7986102432042;703.4126504368807;732.2787054751066;745.7464462082918;759.0322339017797;768.9077310722637;5983.730732116978;6104.664243466563;6132.233470816148;6207.844803879939;6309.085182648582;537.1110811606796;556.4824713016852;557.0085248258107;558.2184941082517;565.7595521903174;3709.3137769512728;3820.465134881119;3841.193349396602;3920.7843568604;3990.4413382126527;12596.307203103917;13285.867141328463;13303.800442993363;13316.800247996287;13325;12827.551035713705;12934.611961641165;13098.869011309955;13200.47198112084;13228.801567976489;9261.16649501548;9504.334696571173;9536.570854311572;9544.522773861418;9572.952135239279;5821.679807610622;5828.825135245949;5849.590528663123;5852.502537284378;5946.970265148647;11154.274972126786;11658.300501969909;11737.41312934367;11743.17797754149;11756.470958806703;11241.71895702614;11297.71755706114;11369.772604547697;11526.423678816192;11528.538858445903;7929.762107136795;7942.12636609984;8256.587170641324;8331.16688331162;8346.374021948257;9269.536523173949;9298.628054877729;9385.906140938776;9409.247260219028;9435.811283774423;7664.80837979055;7677.9616101921365;7698.153203147537;7749.457537972288;7918.129005809241;7747.186545412876;7785.961070194613;7897.605119743875;7922.286994170552;8098;6691.5650482718465;6900.171979362509;6953.374196322356;6969.860602788017;7478;4106.979465102655;5116.411612664591;5194.506521880416;5309.57523398135;5349.4650534946195;5017.12200364942;5024.181621967258;5109.795608175631;5154.433012368711;5198.428172901054 07:17:29 INFO - PID 26753 | |4;prototype.html;396.1601405021355;396.35592162735554;398.2859832065985;401.94774679291726;409.21022426716445;5466;5523.723813809309;5533.750981205845;5552.667359833641;5563.193336966137;4882.804687812492;5393.622446428752;5429.945700542993;5432.429594892538;5471.398146203925;4341.6092551670345;4342.066455712022;4347.13057388522;4348.7390756554705;4350.477942646887;4324.54592267812;4328.134373125387;4330.545292744264;4341;4352.608265256126;4213.620774130328;4291.699581029329;4299.828006879737;4325.82696692132;4327.567243275663;4303.569643035671;4304.203722311382;4307.461567304087;4312.417823593822;4312.482502099737;3839.3281175794405;3858.884233473;3865.714142978446;3872.8644497442738;3879.262940041411;5192.974739851461;5257.342832145981;5298.251576979626;5319.5744340452675;5343.759530821122;5022;5035.8489245322335;5040.747962601855;5047.141985862412;5052.964142350809;5769.596128271022;5778.728679690461;5784.739686714108;5788.536917046668;5815.418458154193;4134;4244.957550424487;4258.914821703549;4277.187334406484;4284.957150428519;5763;5948.524118070544;6000.819975400745;6010.819675409744;6018.789342372996;4276.337167739005;4347.282698354799;4363.6072753452345;4401.779911004501;4402.933955990663;4444.2000439920475;4450;4451.3545535897765;4454.510003899633;4460.754658493749;4891.828785992544;4981.42713587942;5003.124453220672;5003.249512573143;5032.496750324938;5756.5682573807135;5820.156077368758;5824.213731146326;5826.796062137805;5862.765489380462;1548.6980038892534;1562.7030864135777;1563.6012816731889;1565.4990403071135;1566.5535322433052;1048.8148392316787;1104.8895110488886;1109.362116782853;1110.4614262082882;1123.07346439188;5058.620603454756;5062.594992400599;5072.365954255718;5074.3657042869645;5098.694078355311;5981.491573216238;5996.190514280604;6005.729742161613;6028.336882942873;6030.5778595497895;4888.755562221874;5013.298138260647;5060.291559181717;5060.291559181717;5070.783012077149;3139.372125574894;3170.682931706811;3179.3959147761852;3193.1857376368876;3199.792013519114;5398.73006349681;5580.693061881636;5586.190002449622;5592.384837667853;5619.129034999582;6041.516678665696;6085.513158947274;6089.543284253698;6098.634081955008;6104.603200792023;5533.916991245215;5543.7782488700805;5566.332040155126;5568.66352075499;5583.878126311975;5605.4114317997655;5949;5951.285845698544;5956.702164891652;6014.578979471395;5905.261842269716;5913.172155898092;5923.526117910643;5932.466078052996;5943.52451803846;5279.413087586978;5375.811846585507;5501.0648189807025;5586.497215250647;5602.2717046783655;4048.4939382577177;4058.2695114879607;4067.9593204068765;4077.796110194538;4082.9795851020554;5965.552583556338;5982.312034116132;6004.219451471281;6005.429484198994;6011.428914253139;5580.665160090408;5789.507891829242;5816.243888294494;5819.94180058194;5852.209951656472;5783.884322313615;5803.7388317524965;5811.738471768866;5827.854303642443;5830.5627077968475;5615.410381910004;5691.573132015198;5743.702518992436;5753.626014309224;5767.480926716447;5839.182514447895;5843.474087332161;5845.941540584539;5849.795257165979;5862.355140934408;5630.8029218977135;5654.830355089354;5656.547476201812;5661.66030038199;5666.34836993751 07:17:29 INFO - PID 26753 | |5;yui.html;693.930606939306;695.5861262548782;696.0603185699304;696.895465680148;701.705283780812;12899.09706320558;13477.39351729172;13483.3258337083;13515.459381624747;13516.797248041275;13025.915853463448;13073.346332683352;13082.411291491882;13233.801492977589;13321.866781332208;827.3835992185815;843.6709683223517;850.9276711479532;853.0403296291672;854.5855260198798;862.4092496639822;864.5158711121792;867.6746220167437;868.1492137705053;868.3140319147866;901.3915606965305;907.133687328603;907.1790030022806;908.5411867007185;911.7401540560908;894.0523045571715;898.1557336104074;903.6746771162376;905.5155491811915;909.5815924674657;658.3252166529346;661.3981277037873;662.3641304347784;662.4567854359427;666.0974379715512;13295.601131966056;13666.453341866314;14456.421743130262;14524.419023239057;14561.927190364086;12647.557335493306;13441.32793360338;13649.46908182386;14051.43794248229;14087.506937257147;10041.949790251001;10402.167826573856;10408.635697750542;10500.684979450629;10566.788664226673;2614.4771045790726;2642.2205449392477;2662.015054429854;2706.9187924362104;2719.4832981733407;59279;60363.69818150925;61169.388306116816;61337.07994380043;62103.378966210665;10346.793064138676;10413.219008574388;10536.209784266211;10587.205959553065;10924.781504369868;19362.322318718776;19371.4188574343;19407.611847762964;19472.123754431086;19543;6460.870782584416;6644.966775166094;6682.365175308338;6856.794296171123;6877.4841886858685;3440.3807314683595;3527.835814181314;3540.5574303212097;3545.5213546171453;3634.9636503635156;3448.103493091814;3493.3537295600395;3524.0308915048054;3524.753267271318;3535.5403797506674;665.3878431842717;678.5250324772679;681.325487767107;699.7795694356262;703.6833424958687;487.91461494238365;493.4103746023539;497.5994324568757;508.9612832953714;508.96691715038406;7901.407394445439;7954.045514538292;8078.959605201936;8164.346852251806;8392.412531122764;507.4443484384593;522.4957915611453;523.2360753300148;523.4425337016065;532.7389579106288;3516.5252690886914;3602.8018458985007;3653.598104208535;3690.5202323698286;3803.8098095095133;58663;59533.70233148893;59540.404595953485;60719.392806072254;61064.38935610676;52863.73568132135;53832.61673832585;54052;55709.1643625346;55880.16179757307;47046.618686377704;47241.291380629315;47521.762391187825;48650.270245947046;49291.753541232065;7139.8572028560175;7257.2742725727;7312.707491700273;7485.625718714152;7566.281203285679;21578.352649420543;21983.34049978503;25487.617685734356;25927.351816204748;26041;31412.842935785175;32329.51505727463;32430.83784581062;32471.18822029468;33431.16422089467;9400.529973501434;9516.762080948032;9529.380590261611;9653.276004299565;10068.093871551595;9562.235021198148;9641.614335426504;9770.755731106496;9998.700038998843;10056.748581285527;9434;9616.134547890724;9839.60641574329;9872.851907221253;9931.553080111556;9735;9893.802123957625;10053.497325133569;10106.545205465918;10209.897901020895;9712.9028709712;9765.169960553148;9816.607335706492;9905.356151850106;10253.948730256301;6612.140421745335;6669.433098186709;6855.348741869514;6922.342377474132;7796.84406311882;9686.660966866126;9898.455584942898;10000.399976001463;10211.183105351405;10574.312669676447 07:17:29 INFO - PID 26753 | __end_tp_report 07:17:29 INFO - PID 26753 | __start_cc_report 07:17:29 INFO - PID 26753 | _x_x_mozilla_cycle_collect,384 07:17:29 INFO - PID 26753 | __end_cc_report 07:17:29 INFO - PID 26753 | __startTimestamp1490365049341__endTimestamp 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | ------- Summary: start ------- 07:17:29 INFO - PID 26753 | Number of tests: 6 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#0] dojo.html Cycles:165 Average:5207.39 Median:5341.76 stddev:579.84 (10.9%) stddev-sans-first:547.69 07:17:29 INFO - PID 26753 | Values: 2716.1 2728.4 2741.1 2758.8 2763.9 5202.1 5264.8 5293.7 5299.2 5309.6 5216.3 5239.8 5276.0 5333.3 5342.8 4793.1 4824.1 4840.3 4852.0 4870.6 4834.9 4847.4 4902.3 4906.4 4947.1 4727.4 4749.9 4752.3 4821.5 4824.6 4776.7 4791.7 4809.9 4837.8 4843.8 4683.4 4747.1 4754.4 4767.7 4797.0 5138.5 5145.8 5245.4 5266.8 5315.4 5562.0 5635.2 5638.2 5644.2 5701.1 5714.5 5719.7 5736.1 5738.7 5750.8 5179.2 5306.2 5309.1 5323.7 5374.2 5644.4 5713.9 5720.6 5733.0 5736.2 5441.2 5448.6 5464.0 5466.0 5492.8 5511.3 5533.8 5537.8 5557.5 5581.0 5606.1 5606.3 5612.7 5612.9 5633.5 5605.4 5619.9 5621.0 5628.9 5632.6 4766.8 4770.8 4775.9 4782.7 4787.6 4097.4 4099.2 4107.7 4109.6 4145.4 4899.6 4908.3 4913.0 4919.5 4939.6 5597.8 5658.3 5704.3 5716.5 5729.3 4923.1 4925.1 4932.1 4943.0 4996.1 5111.4 5122.8 5132.9 5138.0 5170.3 5231.6 5290.1 5300.2 5341.8 5350.3 5728.9 5738.1 5748.2 5788.3 5798.9 5321.9 5328.5 5333.8 5336.1 5341.8 5452.8 5567.7 5594.8 5626.7 5680.9 5606.3 5626.5 5638.6 5645.9 5667.5 5430.2 5460.4 5471.4 5475.5 5490.2 5509.4 5535.3 5578.9 5595.8 5614.8 5409.3 5425.7 5464.5 5478.1 5483.6 5429.8 5597.7 5606.7 5610.9 5669.4 5267.2 5394.6 5409.5 5429.1 5475.3 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#1] ext.html Cycles:180 Average:33817.29 Median:3012.08 stddev:52297.24 (1736.3%) stddev-sans-first:52384.78 07:17:29 INFO - PID 26753 | Values: 685.3 694.9 1057.9 1069.4 1169.2 31837.0 32788.8 32850.5 32887.0 33017.7 32451.4 32848.0 32873.8 32904.7 32950.3 6972.7 7108.7 7120.7 7335.3 7509.2 7416.2 7623.4 7625.7 7691.4 7714.5 7682.4 7698.6 7749.0 7754.4 7773.0 7666.0 7679.1 7687.5 7703.0 7706.7 7502.9 7556.3 7559.3 7561.0 7563.0 34912.0 35074.5 35386.0 35403.0 35501.5 2709.9 2740.7 2741.1 2770.3 2782.4 23781.0 24132.6 24164.9 24218.6 24390.8 2921.3 2974.4 3010.3 3013.8 3045.3 137151.3 138175.9 139975.0 140034.3 140109.0 33661.3 34199.1 38626.4 44785.0 45431.8 46902.5 47080.5 47472.0 47585.8 47617.0 12414.5 12588.6 12593.9 12597.9 12626.9 9827.6 9853.3 9854.7 9855.2 9875.7 13446.5 13475.7 13511.2 13618.6 13673.9 5556.5 5651.5 5690.0 5742.6 5797.2 854.8 875.5 883.9 888.6 917.8 20312.7 21261.9 21419.6 21484.0 21607.9 975.0 976.7 996.3 1004.3 1004.9 10481.8 11113.3 11153.3 11195.0 11361.5 235555.0 237742.0 238832.0 239255.0 239756.0 42199.8 42841.1 42917.8 42945.8 43029.0 1207.7 1247.5 1252.9 1255.9 1260.4 19792.3 19900.3 20807.4 20959.3 21015.9 30533.7 30541.7 30881.1 30884.5 30929.5 210572.0 211541.0 211698.0 211787.0 212012.0 28628.9 28697.7 28707.0 28793.6 29873.9 33702.5 34718.8 36725.8 37672.0 37775.6 27489.3 28259.9 28724.7 29118.6 29144.9 28216.6 28609.1 28815.0 29116.6 29219.6 29843.7 29927.6 29928.0 31298.7 31358.5 25815.7 26267.1 26290.9 26569.5 26665.5 20813.7 22346.6 22524.0 22814.7 22937.2 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#2] jquery.html Cycles:180 Average:25860.55 Median:43863.06 stddev:66108.87 (150.7%) stddev-sans-first:66266.72 07:17:29 INFO - PID 26753 | Values: 415.5 419.5 423.4 437.6 446.7 16112.4 16296.5 16986.8 17032.3 17689.8 16603.3 16885.6 17006.9 17285.9 17558.3 5517.8 5524.8 5647.0 5651.2 5684.4 5595.4 5658.7 5659.4 5680.0 5687.3 5444.0 5630.3 5648.7 5649.7 5676.2 5568.4 5612.2 5612.8 5655.1 5674.1 4944.2 5038.2 5048.5 5093.4 5115.6 22000.8 22161.8 22313.7 22367.2 22392.6 1534.3 1574.5 1586.9 1592.4 1611.9 13634.6 13901.0 13964.0 14635.7 14752.2 1734.6 1757.2 1791.4 1793.5 1809.4 85271.0 87105.1 87378.6 88100.6 89148.1 10884.7 11039.6 11121.0 11164.0 11267.7 15238.8 15249.1 15268.2 15281.8 15339.5 7036.8 7365.1 7451.4 7493.9 7595.4 6861.2 6884.8 7081.7 7103.1 7150.8 6865.0 6931.4 6986.5 7056.7 7082.6 2081.5 2085.5 2097.2 2101.1 2228.9 821.7 842.2 851.2 852.3 881.4 16259.3 16645.0 16983.3 17076.3 17729.5 853.4 853.6 870.4 871.8 873.1 9475.8 9511.0 9536.0 9590.9 9756.4 287102.0 414059.0 420406.0 422005.0 422617.0 82213.5 85956.0 85965.0 86460.6 86858.6 1051.6 1073.7 1080.1 1082.7 1084.7 14540.3 16342.2 17977.6 18022.6 18113.2 42816.0 42961.4 43670.3 43862.6 43863.6 47796.4 48583.1 56549.7 57791.0 58067.0 7827.8 7871.1 7982.6 8136.3 8241.5 11531.0 12198.7 12199.4 12244.9 12343.6 10381.6 10562.2 10598.5 10646.9 11017.4 9588.3 9638.8 9739.4 9838.0 9848.8 10686.8 10817.7 10824.9 11209.3 11314.2 8143.8 8234.8 8322.0 8408.8 8467.9 9836.3 9938.9 10024.4 10132.1 10368.3 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#3] mootools.html Cycles:180 Average:6262.64 Median:4865.32 stddev:4008.62 (82.4%) stddev-sans-first:4002.28 07:17:29 INFO - PID 26753 | Values: 1265.9 1320.6 1350.6 1352.7 1355.4 9707.6 9873.9 10218.7 10225.3 10233.8 10002.0 10164.6 10171.2 10477.6 10487.7 2271.6 2315.0 2320.9 2328.1 2329.0 2155.5 2170.5 2176.9 2179.7 2307.3 2099.0 2135.0 2271.6 2276.1 2292.2 2125.1 2151.2 2160.1 2168.0 2172.7 1803.0 1868.5 2176.3 2188.1 2260.2 9776.1 9875.3 9955.8 9966.0 9978.8 5502.4 5754.8 5755.8 5769.8 5779.8 3239.6 3285.1 3327.2 3356.9 3419.2 937.8 943.9 955.8 982.8 1021.1 15040.5 15047.2 15130.2 15132.3 15146.6 4792.7 4937.9 4940.2 4975.6 5070.1 11036.1 11043.7 11078.1 11085.6 11107.2 5595.7 5606.5 5620.6 5635.6 5673.3 4977.1 5084.0 5116.5 5193.2 5201.4 3730.8 3832.4 3858.1 3876.3 3893.5 1101.5 1112.1 1131.5 1133.4 1150.8 703.4 732.3 745.7 759.0 768.9 5983.7 6104.7 6132.2 6207.8 6309.1 537.1 556.5 557.0 558.2 565.8 3709.3 3820.5 3841.2 3920.8 3990.4 12596.3 13285.9 13303.8 13316.8 13325.0 12827.6 12934.6 13098.9 13200.5 13228.8 9261.2 9504.3 9536.6 9544.5 9573.0 5821.7 5828.8 5849.6 5852.5 5947.0 11154.3 11658.3 11737.4 11743.2 11756.5 11241.7 11297.7 11369.8 11526.4 11528.5 7929.8 7942.1 8256.6 8331.2 8346.4 9269.5 9298.6 9385.9 9409.2 9435.8 7664.8 7678.0 7698.2 7749.5 7918.1 7747.2 7786.0 7897.6 7922.3 8098.0 6691.6 6900.2 6953.4 6969.9 7478.0 4107.0 5116.4 5194.5 5309.6 5349.5 5017.1 5024.2 5109.8 5154.4 5198.4 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#4] prototype.html Cycles:180 Average:4821.91 Median:5331.67 stddev:1368.68 (25.7%) stddev-sans-first:1331.60 07:17:29 INFO - PID 26753 | Values: 396.2 396.4 398.3 401.9 409.2 5466.0 5523.7 5533.8 5552.7 5563.2 4882.8 5393.6 5429.9 5432.4 5471.4 4341.6 4342.1 4347.1 4348.7 4350.5 4324.5 4328.1 4330.5 4341.0 4352.6 4213.6 4291.7 4299.8 4325.8 4327.6 4303.6 4304.2 4307.5 4312.4 4312.5 3839.3 3858.9 3865.7 3872.9 3879.3 5193.0 5257.3 5298.3 5319.6 5343.8 5022.0 5035.8 5040.7 5047.1 5053.0 5769.6 5778.7 5784.7 5788.5 5815.4 4134.0 4245.0 4258.9 4277.2 4285.0 5763.0 5948.5 6000.8 6010.8 6018.8 4276.3 4347.3 4363.6 4401.8 4402.9 4444.2 4450.0 4451.4 4454.5 4460.8 4891.8 4981.4 5003.1 5003.2 5032.5 5756.6 5820.2 5824.2 5826.8 5862.8 1548.7 1562.7 1563.6 1565.5 1566.6 1048.8 1104.9 1109.4 1110.5 1123.1 5058.6 5062.6 5072.4 5074.4 5098.7 5981.5 5996.2 6005.7 6028.3 6030.6 4888.8 5013.3 5060.3 5060.3 5070.8 3139.4 3170.7 3179.4 3193.2 3199.8 5398.7 5580.7 5586.2 5592.4 5619.1 6041.5 6085.5 6089.5 6098.6 6104.6 5533.9 5543.8 5566.3 5568.7 5583.9 5605.4 5949.0 5951.3 5956.7 6014.6 5905.3 5913.2 5923.5 5932.5 5943.5 5279.4 5375.8 5501.1 5586.5 5602.3 4048.5 4058.3 4068.0 4077.8 4083.0 5965.6 5982.3 6004.2 6005.4 6011.4 5580.7 5789.5 5816.2 5819.9 5852.2 5783.9 5803.7 5811.7 5827.9 5830.6 5615.4 5691.6 5743.7 5753.6 5767.5 5839.2 5843.5 5845.9 5849.8 5862.4 5630.8 5654.8 5656.5 5661.7 5666.3 07:17:29 INFO - PID 26753 | 07:17:29 INFO - PID 26753 | [#5] yui.html Cycles:180 Average:13405.36 Median:53942.31 stddev:16639.78 (30.8%) stddev-sans-first:16659.08 07:17:29 INFO - PID 26753 | Values: 693.9 695.6 696.1 696.9 701.7 12899.1 13477.4 13483.3 13515.5 13516.8 13025.9 13073.3 13082.4 13233.8 13321.9 827.4 843.7 850.9 853.0 854.6 862.4 864.5 867.7 868.1 868.3 901.4 907.1 907.2 908.5 911.7 894.1 898.2 903.7 905.5 909.6 658.3 661.4 662.4 662.5 666.1 13295.6 13666.5 14456.4 14524.4 14561.9 12647.6 13441.3 13649.5 14051.4 14087.5 10041.9 10402.2 10408.6 10500.7 10566.8 2614.5 2642.2 2662.0 2706.9 2719.5 59279.0 60363.7 61169.4 61337.1 62103.4 10346.8 10413.2 10536.2 10587.2 10924.8 19362.3 19371.4 19407.6 19472.1 19543.0 6460.9 6645.0 6682.4 6856.8 6877.5 3440.4 3527.8 3540.6 3545.5 3635.0 3448.1 3493.4 3524.0 3524.8 3535.5 665.4 678.5 681.3 699.8 703.7 487.9 493.4 497.6 509.0 509.0 7901.4 7954.0 8079.0 8164.3 8392.4 507.4 522.5 523.2 523.4 532.7 3516.5 3602.8 3653.6 3690.5 3803.8 58663.0 59533.7 59540.4 60719.4 61064.4 52863.7 53832.6 54052.0 55709.2 55880.2 47046.6 47241.3 47521.8 48650.3 49291.8 7139.9 7257.3 7312.7 7485.6 7566.3 21578.4 21983.3 25487.6 25927.4 26041.0 31412.8 32329.5 32430.8 32471.2 33431.2 9400.5 9516.8 9529.4 9653.3 10068.1 9562.2 9641.6 9770.8 9998.7 10056.7 9434.0 9616.1 9839.6 9872.9 9931.6 9735.0 9893.8 10053.5 10106.5 10209.9 9712.9 9765.2 9816.6 9905.4 10253.9 6612.1 6669.4 6855.3 6922.3 7796.8 9686.7 9898.5 10000.4 10211.2 10574.3 07:17:29 INFO - PID 26753 | -------- Summary: end -------- 07:17:29 INFO - PID 26753 | 07:17:30 INFO - TEST-INFO | 26753: exit 0 07:17:30 INFO - TEST-OK | dromaeo_css | took 1121626ms 07:17:30 INFO - TEST-START | kraken 07:17:30 INFO - operating with platform_type : linux_ 07:17:30 INFO - Initialising browser for kraken test... 07:17:30 INFO - TEST-INFO | started process 27132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5XKiAz/profile http://localhost:40549/getInfo.html) 07:17:34 INFO - PID 27132 | __metrics Screen width/height:1600/1200 07:17:34 INFO - PID 27132 | colorDepth:24 07:17:34 INFO - PID 27132 | Browser inner width/height: 1024/697 07:17:34 INFO - PID 27132 | __metrics 07:17:34 ERROR - PID 27132 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3392: TypeError: this.tabs is undefined 07:17:35 INFO - TEST-INFO | 27132: exit 0 07:17:35 INFO - Browser initialized. 07:17:35 INFO - Running cycle 1/1 for kraken test... 07:17:35 INFO - TEST-INFO | started process 27265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5XKiAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:48 INFO - PID 27265 | RSS: Main: 156024832 07:17:48 INFO - PID 27265 | 07:17:50 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40549/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:51 INFO - PID 27265 | RSS: Main: 162357248 07:17:51 INFO - PID 27265 | 07:17:54 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40549/tests/kraken/driver.html?testName=audio-dft) 07:17:55 INFO - PID 27265 | RSS: Main: 160968704 07:17:55 INFO - PID 27265 | 07:17:58 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40549/tests/kraken/driver.html?testName=audio-fft) 07:17:58 INFO - PID 27265 | RSS: Main: 157908992 07:17:58 INFO - PID 27265 | 07:18:00 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40549/tests/kraken/driver.html?testName=audio-oscillator) 07:18:01 INFO - PID 27265 | RSS: Main: 158711808 07:18:01 INFO - PID 27265 | 07:18:03 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:04 INFO - PID 27265 | RSS: Main: 159150080 07:18:04 INFO - PID 27265 | 07:18:07 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40549/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:08 INFO - PID 27265 | RSS: Main: 163651584 07:18:08 INFO - PID 27265 | 07:18:11 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40549/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:12 INFO - PID 27265 | RSS: Main: 161484800 07:18:12 INFO - PID 27265 | 07:18:15 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40549/tests/kraken/driver.html?testName=json-parse-financial) 07:18:15 INFO - PID 27265 | RSS: Main: 162045952 07:18:15 INFO - PID 27265 | 07:18:17 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:18 INFO - PID 27265 | RSS: Main: 162988032 07:18:18 INFO - PID 27265 | 07:18:20 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:20 INFO - PID 27265 | RSS: Main: 162578432 07:18:20 INFO - PID 27265 | 07:18:22 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:23 INFO - PID 27265 | RSS: Main: 163495936 07:18:23 INFO - PID 27265 | 07:18:26 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:27 INFO - PID 27265 | RSS: Main: 163987456 07:18:27 INFO - PID 27265 | 07:18:30 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:31 INFO - PID 27265 | RSS: Main: 163561472 07:18:31 INFO - PID 27265 | 07:18:32 INFO - PID 27265 | Cycle 1(1): loaded http://localhost:40549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40549/tests/kraken/driver.html?testName=ai-astar) 07:18:33 INFO - PID 27265 | RSS: Main: 165564416 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | __start_tp_report 07:18:33 INFO - PID 27265 | _x_x_mozilla_page_load 07:18:33 INFO - PID 27265 | _x_x_mozilla_page_load_details 07:18:33 INFO - PID 27265 | |i|pagename|runs| 07:18:33 INFO - PID 27265 | |0;ai-astar;104;112;113;111;112;112;114;112;112;112 07:18:33 INFO - PID 27265 | |1;audio-beat-detection;154;124;124;181;125;124;125;124;148;126 07:18:33 INFO - PID 27265 | |2;audio-dft;164;166;166;169;166;170;166;166;163;165 07:18:33 INFO - PID 27265 | |3;audio-fft;75;75;76;110;76;75;79;78;112;77 07:18:33 INFO - PID 27265 | |4;audio-oscillator;86;84;104;86;85;85;101;87;85;108 07:18:33 INFO - PID 27265 | |5;imaging-gaussian-blur;113;114;113;115;114;119;115;113;115;115 07:18:33 INFO - PID 27265 | |6;imaging-darkroom;151;150;150;152;155;150;150;150;151;150 07:18:33 INFO - PID 27265 | |7;imaging-desaturate;96;96;94;96;97;96;94;95;96;95 07:18:33 INFO - PID 27265 | |8;json-parse-financial;68;66;67;68;69;70;70;69;70;69 07:18:33 INFO - PID 27265 | |9;json-stringify-tinderbox;55;55;55;55;55;54;55;54;55;54 07:18:33 INFO - PID 27265 | |10;stanford-crypto-aes;83;83;84;84;84;83;84;81;83;84 07:18:33 INFO - PID 27265 | |11;stanford-crypto-ccm;143;151;137;138;135;144;137;133;189;138 07:18:33 INFO - PID 27265 | |12;stanford-crypto-pbkdf2;198;203;207;196;198;199;196;203;196;201 07:18:33 INFO - PID 27265 | |13;stanford-crypto-sha256-iterative;72;74;72;79;71;72;73;71;71;72 07:18:33 INFO - PID 27265 | __end_tp_report 07:18:33 INFO - PID 27265 | __start_cc_report 07:18:33 INFO - PID 27265 | _x_x_mozilla_cycle_collect,867 07:18:33 INFO - PID 27265 | __end_cc_report 07:18:33 INFO - PID 27265 | __startTimestamp1490365113221__endTimestamp 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | ------- Summary: start ------- 07:18:33 INFO - PID 27265 | Number of tests: 14 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.72 (2.4%) stddev-sans-first:0.83 07:18:33 INFO - PID 27265 | Values: 104.0 112.0 113.0 111.0 112.0 112.0 114.0 112.0 112.0 112.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:125.50 stddev:19.46 (15.5%) stddev-sans-first:19.46 07:18:33 INFO - PID 27265 | Values: 154.0 124.0 124.0 181.0 125.0 124.0 125.0 124.0 148.0 126.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:2.08 (1.3%) stddev-sans-first:2.06 07:18:33 INFO - PID 27265 | Values: 164.0 166.0 166.0 169.0 166.0 170.0 166.0 166.0 163.0 165.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:14.67 (19.3%) stddev-sans-first:15.25 07:18:33 INFO - PID 27265 | Values: 75.0 75.0 76.0 110.0 76.0 75.0 79.0 78.0 112.0 77.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:85.00 stddev:9.31 (11.0%) stddev-sans-first:9.70 07:18:33 INFO - PID 27265 | Values: 86.0 84.0 104.0 86.0 85.0 85.0 101.0 87.0 85.0 108.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:1.78 (1.5%) stddev-sans-first:1.79 07:18:33 INFO - PID 27265 | Values: 113.0 114.0 113.0 115.0 114.0 119.0 115.0 113.0 115.0 115.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#6] imaging-darkroom Cycles:10 Average:150.90 Median:150.50 stddev:1.60 (1.1%) stddev-sans-first:1.69 07:18:33 INFO - PID 27265 | Values: 151.0 150.0 150.0 152.0 155.0 150.0 150.0 150.0 151.0 150.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 07:18:33 INFO - PID 27265 | Values: 96.0 96.0 94.0 96.0 97.0 96.0 94.0 95.0 96.0 95.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#8] json-parse-financial Cycles:10 Average:68.60 Median:69.00 stddev:1.35 (2.0%) stddev-sans-first:1.41 07:18:33 INFO - PID 27265 | Values: 68.0 66.0 67.0 68.0 69.0 70.0 70.0 69.0 70.0 69.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:18:33 INFO - PID 27265 | Values: 55.0 55.0 55.0 55.0 55.0 54.0 55.0 54.0 55.0 54.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:84.00 stddev:0.95 (1.1%) stddev-sans-first:1.00 07:18:33 INFO - PID 27265 | Values: 83.0 83.0 84.0 84.0 84.0 83.0 84.0 81.0 83.0 84.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:140.50 stddev:16.48 (11.7%) stddev-sans-first:17.47 07:18:33 INFO - PID 27265 | Values: 143.0 151.0 137.0 138.0 135.0 144.0 137.0 133.0 189.0 138.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.70 Median:200.00 stddev:3.71 (1.9%) stddev-sans-first:3.89 07:18:33 INFO - PID 27265 | Values: 198.0 203.0 207.0 196.0 198.0 199.0 196.0 203.0 196.0 201.0 07:18:33 INFO - PID 27265 | 07:18:33 INFO - PID 27265 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:72.00 stddev:2.41 (3.3%) stddev-sans-first:2.54 07:18:33 INFO - PID 27265 | Values: 72.0 74.0 72.0 79.0 71.0 72.0 73.0 71.0 71.0 72.0 07:18:33 INFO - PID 27265 | -------- Summary: end -------- 07:18:33 INFO - PID 27265 | 07:18:34 INFO - TEST-INFO | 27265: exit 0 07:18:34 INFO - TEST-OK | kraken | took 64256ms 07:18:34 INFO - SUITE-END | took 1185s 07:18:34 INFO - Completed test suite (00:19:46) 07:18:34 INFO - javascript benchmark 07:18:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6618.058766438716, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.0629582793936, 2728.4406696627193, 2741.1091395296535, 2758.7517123458883, 2763.8894444222233, 5202.141646628302, 5264.763085661145, 5293.682379057259, 5299.178627312763, 5309.575233981282, 5216.29580006699, 5239.764210610522, 5275.973620131904, 5333.253344531759, 5342.759575819087, 4793.137235297654, 4824.0834241494, 4840.322354870321, 4852.0, 4870.634702397317, 4834.927476087862, 4847.369841920546, 4902.313676085333, 4906.435759887623, 4947.084789313971, 4727.409073865767, 4749.907521270093, 4752.310914917352, 4821.54195351441, 4824.565789079, 4776.713397196179, 4791.688540244873, 4809.879753006167, 4837.830675926326, 4843.782029808667, 4683.437987441494, 4747.074320507502, 4754.405699287589, 4767.737774422405, 4796.976015119937, 5138.511841375101, 5145.845624631267, 5245.396779370383, 5266.789328426858, 5315.362156541201, 5561.972190139064, 5635.21107045014, 5638.210650508932, 5644.153376993443, 5701.116326969326, 5714.51426628737, 5719.71401429931, 5736.110902810029, 5738.741756620962, 5750.769969201227, 5179.249008893765, 5306.151015837448, 5309.070912590281, 5323.707196104213, 5374.167004114369, 5644.435556444405, 5713.914291285634, 5720.599558030898, 5733.0, 5736.225609542742, 5441.156620723794, 5448.591355648263, 5464.043792336325, 5465.9726701367035, 5492.752826122834, 5511.283533140746, 5533.833984980457, 5537.833864984057, 5557.472040156179, 5581.023320918823, 5606.103023516218, 5606.327240731139, 5612.691301978349, 5612.859678507988, 5633.464820842013, 5605.383407825136, 5619.8595035124445, 5621.016322143609, 5628.915566266509, 5632.577556683265, 4766.833160839354, 4770.76146192689, 4775.856724298276, 4782.689125206851, 4787.569118779257, 4097.426360309559, 4099.1801639672185, 4107.712460127822, 4109.56849530795, 4145.3781932709735, 4899.608031357483, 4908.312836202935, 4913.0, 4919.458859525449, 4939.629527785431, 5597.776088956396, 5658.321001479849, 5704.34400043992, 5716.5140963017775, 5729.312482502127, 4923.08922849274, 4925.113479573711, 4932.087563800708, 4942.950570494321, 4996.1007018736245, 5111.361079865017, 5122.846314610568, 5132.923006154911, 5138.0, 5170.250313704567, 5231.581473482189, 5290.127129023822, 5300.178472336794, 5341.75962081715, 5350.30446042012, 5728.914066289092, 5738.081906895044, 5748.166515855261, 5788.27646544182, 5798.884022319446, 5321.893562128813, 5328.547073498796, 5333.813316533902, 5336.09286421317, 5341.75962081715, 5452.809151679831, 5567.66594004361, 5594.832155035356, 5626.690532020778, 5680.943190568207, 5606.299212598426, 5626.465485778845, 5638.605297629127, 5645.887082258249, 5667.4615911488345, 5430.212619170277, 5460.3720572133125, 5471.398146203994, 5475.4524547544925, 5490.176473529003, 5509.449055094458, 5535.280413546213, 5578.940001399721, 5595.832125036255, 5614.831555053355, 5409.323834520685, 5425.728713564385, 5464.508194262536, 5478.068728316275, 5483.643563168382, 5429.7556609953435, 5597.692126933058, 5606.719664016701, 5610.887782244414, 5669.376368599368, 5267.209918512254, 5394.595405344537, 5409.486098820606, 5429.077056900257, 5475.315585551806], "value": 5166.4210694865105, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.2941470285605, 694.9298080955328, 1057.9312344697594, 1069.4385447639993, 1169.2341516306822, 31837.0, 32788.7537993921, 32850.50724239135, 32887.0, 33017.66982330176, 32451.350972980526, 32848.0, 32873.83563082187, 32904.67095329046, 32950.34099318018, 6972.721091156348, 7108.715651373939, 7120.679569419362, 7335.339819416252, 7509.249075092502, 7416.184219735825, 7623.352015078725, 7625.6568454419685, 7691.384689224877, 7714.459987800856, 7682.423818213629, 7698.6150692465435, 7749.0, 7754.418418618598, 7772.961135194316, 7666.0, 7679.116901556336, 7687.500312479727, 7703.037120359955, 7706.6917323307, 7502.887456688154, 7556.282153195492, 7559.28186822251, 7561.0, 7562.9789978352765, 34912.0, 35074.473882891776, 35386.0, 35403.0, 35501.46747798785, 2709.9322516937036, 2740.6985231624503, 2741.0543362539893, 2770.293575138347, 2782.38787466757, 23781.0, 24132.63801042986, 24164.879175604186, 24218.63672044921, 24390.756092439202, 2921.26790382379, 2974.3605124898036, 3010.307629245264, 3013.8493075346146, 3045.33002739397, 137151.31424342914, 138175.92736108968, 139975.0, 140034.2998285012, 140109.0, 33661.326773464396, 34199.14502137417, 38626.42060369097, 44785.0, 45431.772841135586, 46902.53097468981, 47080.5291947083, 47472.0, 47585.76207118942, 47617.0, 12414.503419863104, 12588.559400420942, 12593.93703031479, 12597.874021259853, 12626.936865315798, 9827.557759900821, 9853.310268281151, 9854.655087071918, 9855.162311203485, 9875.654352097643, 13446.46214151423, 13475.730485390237, 13511.189328640314, 13618.591442256748, 13673.931630341785, 5556.527695145958, 5651.547876169979, 5689.971550142222, 5742.569307301969, 5797.188393624896, 854.7905763088083, 875.4834647557972, 883.88067610873, 888.6401007591936, 917.7751450894574, 20312.69530957037, 21261.893690531448, 21419.57160856774, 21484.0, 21607.89196054041, 975.0, 976.6679329028165, 996.267743208741, 1004.3421558878946, 1004.8693669822876, 10481.790364192673, 11113.277636953571, 11153.275037122561, 11194.977356113966, 11361.488733007034, 235555.0, 237742.0, 238832.0, 239255.0, 239756.0, 42199.7890010548, 42841.143177136284, 42917.78541107337, 42945.785271073444, 43029.0, 1207.7342984543386, 1247.4511215065343, 1252.8809763072493, 1255.8681338459512, 1260.3635164241998, 19792.307269245506, 19900.303489377802, 20807.375778726662, 20959.26642567503, 21015.8949205253, 30533.694663053084, 30541.694583053886, 30881.073567793002, 30884.53673194859, 30929.536056958714, 210572.0, 211541.0, 211698.0, 211787.0, 212012.0, 28628.85685571559, 28697.71302287034, 28707.0, 28793.56809647815, 29873.850630746707, 33702.49446258259, 34718.82640586781, 36725.81637091797, 37672.0, 37775.62224377831, 27489.31276718098, 28259.92585237357, 28724.712752872205, 29118.56322155127, 29144.854275728485, 28216.576751348337, 28609.14172574826, 28815.0, 29116.563251551666, 29219.561706573993, 29843.701562984093, 29927.55108673328, 29928.0, 31298.687013129576, 31358.529622056143, 25815.741842581334, 26267.080652177083, 26290.868545657147, 26569.468610628064, 26665.466690666464, 20813.687794682788, 22346.553068938207, 22524.0, 22814.657780133643, 22937.197198097987], "value": 15020.165449077953, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.47442485256136, 419.5489848412955, 423.3874744749808, 437.6455071392173, 446.72526396266284, 16112.436064737707, 16296.511104666864, 16986.83013169868, 17032.31870725171, 17689.82310176898, 16603.252853621587, 16885.57786055349, 17006.914965425185, 17285.913570432163, 17558.29766809329, 5517.751701173457, 5524.806631767879, 5646.971765141168, 5651.2370829937845, 5684.403137670547, 5595.440455954393, 5658.660480371191, 5659.4340565943485, 5680.0, 5687.345955215141, 5443.972780136094, 5630.268065151525, 5648.6893220872835, 5649.661020338793, 5676.205331253628, 5568.443155684439, 5612.214289999403, 5612.7754889804355, 5655.123455864327, 5674.120511320752, 4944.159492886218, 5038.193888977746, 5048.469910659402, 5093.414257360414, 5115.641905066647, 22000.779992200034, 22161.778382216133, 22313.665295020586, 22367.217147399762, 22392.552148957093, 1534.3325653340833, 1574.480421460915, 1586.8730501559849, 1592.3710134496926, 1611.8871678982475, 13634.590962271148, 13901.0, 13964.0, 14635.70728585433, 14752.188629625367, 1734.5663584103975, 1757.2443849144863, 1791.3998810398532, 1793.515750747304, 1809.3848091648772, 85271.0, 87105.12894871098, 87378.56310718469, 88100.5594972021, 89148.10851891463, 10884.727881803019, 11039.558417663204, 11121.0, 11164.0, 11267.661970140745, 15238.771418428732, 15249.085054896741, 15268.16025118607, 15281.847181528265, 15339.463118790789, 7036.788896333118, 7365.116186057708, 7451.44114191427, 7493.85012299751, 7595.354394876497, 6861.245263021064, 6884.827879303058, 7081.681324340417, 7103.147622285359, 7150.821229469305, 6865.009147347213, 6931.445484361239, 6986.510944233854, 7056.682449289794, 7082.645867706594, 2081.5004398944448, 2085.4994801247894, 2097.1820989813987, 2101.107029512451, 2228.8662680238913, 821.6507984106851, 842.1914961636775, 851.1743608699552, 852.2500199824115, 881.4358810361374, 16259.349626015064, 16645.0, 16983.320667173175, 17076.316947322215, 17729.46811595654, 853.4196746212511, 853.6457370191301, 870.3602851903846, 871.808202195516, 873.0701802580231, 9475.763105922408, 9511.0, 9535.952320238493, 9590.856137157949, 9756.414615122972, 287102.0, 414059.0, 420406.0, 422005.0, 422617.0, 82213.52922439884, 85956.0, 85965.0, 86460.56769716111, 86858.56570717106, 1051.5530899367739, 1073.7100982734619, 1080.1358912869673, 1082.7401423658266, 1084.6800193942806, 14540.272986350428, 16342.182890855647, 17977.550561236072, 18022.63954720872, 18113.184906679493, 42816.0, 42961.35557966695, 43670.344944825214, 43862.56137438585, 43863.56136438723, 47796.35258358646, 48583.113350932545, 56549.71725141348, 57791.0, 58067.0, 7827.84344313122, 7871.134175240604, 7982.6429506982795, 8136.267735903797, 8241.464304820167, 11531.0, 12198.743232502016, 12199.390030498262, 12244.87755122473, 12343.629691109281, 10381.63664271777, 10562.15502759762, 10598.523066461874, 10646.946765266124, 11017.394043327695, 9588.280878934247, 9638.759031024281, 9739.41563506192, 9837.950810245902, 9848.803023939625, 10686.839697404701, 10817.729556761144, 10824.891751082389, 11209.327440353605, 11314.151438642299, 8143.75568732939, 8234.794130146794, 8322.0, 8408.83182336362, 8467.872981905153, 9836.311458197857, 9938.900610994087, 10024.448655324028, 10132.088112069949, 10368.274220804471], "value": 8796.833035085716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.8923991460726, 1320.6038188543434, 1350.5745690107622, 1352.7429788340214, 1355.3900744664898, 9707.61169553218, 9873.901260987388, 10218.74453138672, 10225.335353202046, 10233.795324093522, 10002.049600327939, 10164.593416263358, 10171.186305095593, 10477.633282835102, 10487.73780655482, 2271.6138256496392, 2314.9652755208685, 2320.872352020638, 2328.1153161798493, 2328.9767102329015, 2155.5150091229507, 2170.5441857209926, 2176.923807666732, 2179.683945827854, 2307.2501437033034, 2098.98950505248, 2134.9893250533723, 2271.602469567819, 2276.1350686739015, 2292.197730794217, 2125.054350813873, 2151.225558798831, 2160.114353115223, 2168.024389024937, 2172.6632371982446, 1802.9549261268573, 1868.4768264885854, 2176.3470958712323, 2188.113813905371, 2260.16373941641, 9776.120149186536, 9875.308728389016, 9955.75110622233, 9966.0, 9978.800423991479, 5502.394736578973, 5754.827355179351, 5755.7625110601, 5769.769209231626, 5779.826605201809, 3239.5626590410466, 3285.1458620758535, 3327.218103745618, 3356.9160770980675, 3419.247765491588, 937.8452555328431, 943.8820147481565, 955.7849483866144, 982.8230918434679, 1021.1167340250704, 15040.548783536402, 15047.172405517693, 15130.243487825564, 15132.319045642973, 15146.621334466727, 4792.7124372537755, 4937.925931111036, 4940.1601727706375, 4975.577075948512, 5070.138076527, 11036.061934735477, 11043.72390690223, 11078.11375090007, 11085.556577736961, 11107.166962477846, 5595.692236926927, 5606.523445507178, 5620.57845661577, 5635.605507614428, 5673.262475878192, 4977.0792403405485, 5083.974580127076, 5116.513931176532, 5193.246979187997, 5201.427842937273, 3730.7948062856804, 3832.352088601928, 3858.054776579756, 3876.341022026262, 3893.53277606689, 1101.515333253366, 1112.071420364005, 1131.4851742457163, 1133.4106264742288, 1150.7986102432042, 703.4126504368807, 732.2787054751066, 745.7464462082918, 759.0322339017797, 768.9077310722637, 5983.730732116978, 6104.664243466563, 6132.233470816148, 6207.844803879939, 6309.085182648582, 537.1110811606796, 556.4824713016852, 557.0085248258107, 558.2184941082517, 565.7595521903174, 3709.3137769512728, 3820.465134881119, 3841.193349396602, 3920.7843568604, 3990.4413382126527, 12596.307203103917, 13285.867141328463, 13303.800442993363, 13316.800247996287, 13325.0, 12827.551035713705, 12934.611961641165, 13098.869011309955, 13200.47198112084, 13228.801567976489, 9261.16649501548, 9504.334696571173, 9536.570854311572, 9544.522773861418, 9572.952135239279, 5821.679807610622, 5828.825135245949, 5849.590528663123, 5852.502537284378, 5946.970265148647, 11154.274972126786, 11658.300501969909, 11737.41312934367, 11743.17797754149, 11756.470958806703, 11241.71895702614, 11297.71755706114, 11369.772604547697, 11526.423678816192, 11528.538858445903, 7929.762107136795, 7942.12636609984, 8256.587170641324, 8331.16688331162, 8346.374021948257, 9269.536523173949, 9298.628054877729, 9385.906140938776, 9409.247260219028, 9435.811283774423, 7664.80837979055, 7677.9616101921365, 7698.153203147537, 7749.457537972288, 7918.129005809241, 7747.186545412876, 7785.961070194613, 7897.605119743875, 7922.286994170552, 8098.0, 6691.5650482718465, 6900.171979362509, 6953.374196322356, 6969.860602788017, 7478.0, 4106.979465102655, 5116.411612664591, 5194.506521880416, 5309.57523398135, 5349.4650534946195, 5017.12200364942, 5024.181621967258, 5109.795608175631, 5154.433012368711, 5198.428172901054], "value": 4678.280571622968, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.1601405021355, 396.35592162735554, 398.2859832065985, 401.94774679291726, 409.21022426716445, 5466.0, 5523.723813809309, 5533.750981205845, 5552.667359833641, 5563.193336966137, 4882.804687812492, 5393.622446428752, 5429.945700542993, 5432.429594892538, 5471.398146203925, 4341.6092551670345, 4342.066455712022, 4347.13057388522, 4348.7390756554705, 4350.477942646887, 4324.54592267812, 4328.134373125387, 4330.545292744264, 4341.0, 4352.608265256126, 4213.620774130328, 4291.699581029329, 4299.828006879737, 4325.82696692132, 4327.567243275663, 4303.569643035671, 4304.203722311382, 4307.461567304087, 4312.417823593822, 4312.482502099737, 3839.3281175794405, 3858.884233473, 3865.714142978446, 3872.8644497442738, 3879.262940041411, 5192.974739851461, 5257.342832145981, 5298.251576979626, 5319.5744340452675, 5343.759530821122, 5022.0, 5035.8489245322335, 5040.747962601855, 5047.141985862412, 5052.964142350809, 5769.596128271022, 5778.728679690461, 5784.739686714108, 5788.536917046668, 5815.418458154193, 4134.0, 4244.957550424487, 4258.914821703549, 4277.187334406484, 4284.957150428519, 5763.0, 5948.524118070544, 6000.819975400745, 6010.819675409744, 6018.789342372996, 4276.337167739005, 4347.282698354799, 4363.6072753452345, 4401.779911004501, 4402.933955990663, 4444.2000439920475, 4450.0, 4451.3545535897765, 4454.510003899633, 4460.754658493749, 4891.828785992544, 4981.42713587942, 5003.124453220672, 5003.249512573143, 5032.496750324938, 5756.5682573807135, 5820.156077368758, 5824.213731146326, 5826.796062137805, 5862.765489380462, 1548.6980038892534, 1562.7030864135777, 1563.6012816731889, 1565.4990403071135, 1566.5535322433052, 1048.8148392316787, 1104.8895110488886, 1109.362116782853, 1110.4614262082882, 1123.07346439188, 5058.620603454756, 5062.594992400599, 5072.365954255718, 5074.3657042869645, 5098.694078355311, 5981.491573216238, 5996.190514280604, 6005.729742161613, 6028.336882942873, 6030.5778595497895, 4888.755562221874, 5013.298138260647, 5060.291559181717, 5060.291559181717, 5070.783012077149, 3139.372125574894, 3170.682931706811, 3179.3959147761852, 3193.1857376368876, 3199.792013519114, 5398.73006349681, 5580.693061881636, 5586.190002449622, 5592.384837667853, 5619.129034999582, 6041.516678665696, 6085.513158947274, 6089.543284253698, 6098.634081955008, 6104.603200792023, 5533.916991245215, 5543.7782488700805, 5566.332040155126, 5568.66352075499, 5583.878126311975, 5605.4114317997655, 5949.0, 5951.285845698544, 5956.702164891652, 6014.578979471395, 5905.261842269716, 5913.172155898092, 5923.526117910643, 5932.466078052996, 5943.52451803846, 5279.413087586978, 5375.811846585507, 5501.0648189807025, 5586.497215250647, 5602.2717046783655, 4048.4939382577177, 4058.2695114879607, 4067.9593204068765, 4077.796110194538, 4082.9795851020554, 5965.552583556338, 5982.312034116132, 6004.219451471281, 6005.429484198994, 6011.428914253139, 5580.665160090408, 5789.507891829242, 5816.243888294494, 5819.94180058194, 5852.209951656472, 5783.884322313615, 5803.7388317524965, 5811.738471768866, 5827.854303642443, 5830.5627077968475, 5615.410381910004, 5691.573132015198, 5743.702518992436, 5753.626014309224, 5767.480926716447, 5839.182514447895, 5843.474087332161, 5845.941540584539, 5849.795257165979, 5862.355140934408, 5630.8029218977135, 5654.830355089354, 5656.547476201812, 5661.66030038199, 5666.34836993751], "value": 4411.710386044586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.930606939306, 695.5861262548782, 696.0603185699304, 696.895465680148, 701.705283780812, 12899.09706320558, 13477.39351729172, 13483.3258337083, 13515.459381624747, 13516.797248041275, 13025.915853463448, 13073.346332683352, 13082.411291491882, 13233.801492977589, 13321.866781332208, 827.3835992185815, 843.6709683223517, 850.9276711479532, 853.0403296291672, 854.5855260198798, 862.4092496639822, 864.5158711121792, 867.6746220167437, 868.1492137705053, 868.3140319147866, 901.3915606965305, 907.133687328603, 907.1790030022806, 908.5411867007185, 911.7401540560908, 894.0523045571715, 898.1557336104074, 903.6746771162376, 905.5155491811915, 909.5815924674657, 658.3252166529346, 661.3981277037873, 662.3641304347784, 662.4567854359427, 666.0974379715512, 13295.601131966056, 13666.453341866314, 14456.421743130262, 14524.419023239057, 14561.927190364086, 12647.557335493306, 13441.32793360338, 13649.46908182386, 14051.43794248229, 14087.506937257147, 10041.949790251001, 10402.167826573856, 10408.635697750542, 10500.684979450629, 10566.788664226673, 2614.4771045790726, 2642.2205449392477, 2662.015054429854, 2706.9187924362104, 2719.4832981733407, 59279.0, 60363.69818150925, 61169.388306116816, 61337.07994380043, 62103.378966210665, 10346.793064138676, 10413.219008574388, 10536.209784266211, 10587.205959553065, 10924.781504369868, 19362.322318718776, 19371.4188574343, 19407.611847762964, 19472.123754431086, 19543.0, 6460.870782584416, 6644.966775166094, 6682.365175308338, 6856.794296171123, 6877.4841886858685, 3440.3807314683595, 3527.835814181314, 3540.5574303212097, 3545.5213546171453, 3634.9636503635156, 3448.103493091814, 3493.3537295600395, 3524.0308915048054, 3524.753267271318, 3535.5403797506674, 665.3878431842717, 678.5250324772679, 681.325487767107, 699.7795694356262, 703.6833424958687, 487.91461494238365, 493.4103746023539, 497.5994324568757, 508.9612832953714, 508.96691715038406, 7901.407394445439, 7954.045514538292, 8078.959605201936, 8164.346852251806, 8392.412531122764, 507.4443484384593, 522.4957915611453, 523.2360753300148, 523.4425337016065, 532.7389579106288, 3516.5252690886914, 3602.8018458985007, 3653.598104208535, 3690.5202323698286, 3803.8098095095133, 58663.0, 59533.70233148893, 59540.404595953485, 60719.392806072254, 61064.38935610676, 52863.73568132135, 53832.61673832585, 54052.0, 55709.1643625346, 55880.16179757307, 47046.618686377704, 47241.291380629315, 47521.762391187825, 48650.270245947046, 49291.753541232065, 7139.8572028560175, 7257.2742725727, 7312.707491700273, 7485.625718714152, 7566.281203285679, 21578.352649420543, 21983.34049978503, 25487.617685734356, 25927.351816204748, 26041.0, 31412.842935785175, 32329.51505727463, 32430.83784581062, 32471.18822029468, 33431.16422089467, 9400.529973501434, 9516.762080948032, 9529.380590261611, 9653.276004299565, 10068.093871551595, 9562.235021198148, 9641.614335426504, 9770.755731106496, 9998.700038998843, 10056.748581285527, 9434.0, 9616.134547890724, 9839.60641574329, 9872.851907221253, 9931.553080111556, 9735.0, 9893.802123957625, 10053.497325133569, 10106.545205465918, 10209.897901020895, 9712.9028709712, 9765.169960553148, 9816.607335706492, 9905.356151850106, 10253.948730256301, 6612.140421745335, 6669.433098186709, 6855.348741869514, 6922.342377474132, 7796.84406311882, 9686.660966866126, 9898.455584942898, 10000.399976001463, 10211.183105351405, 10574.312669676447], "value": 5963.028543256009, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 111.0, 112.0, 112.0, 114.0, 112.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 124.0, 181.0, 125.0, 124.0, 125.0, 124.0, 148.0, 126.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 166.0, 169.0, 166.0, 170.0, 166.0, 166.0, 163.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 110.0, 76.0, 75.0, 79.0, 78.0, 112.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 104.0, 86.0, 85.0, 85.0, 101.0, 87.0, 85.0, 108.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 115.0, 114.0, 119.0, 115.0, 113.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 152.0, 155.0, 150.0, 150.0, 150.0, 151.0, 150.0], "value": 150.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 94.0, 96.0, 97.0, 96.0, 94.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 68.0, 69.0, 70.0, 70.0, 69.0, 70.0, 69.0], "value": 68.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 84.0, 83.0, 84.0, 81.0, 83.0, 84.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 151.0, 137.0, 138.0, 135.0, 144.0, 137.0, 133.0, 189.0, 138.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 203.0, 207.0, 196.0, 198.0, 199.0, 196.0, 203.0, 196.0, 201.0], "value": 199.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 79.0, 71.0, 72.0, 73.0, 71.0, 71.0, 72.0], "value": 72.7, "unit": "score"}]}]} 07:18:34 INFO - Return code: 0 07:18:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:18:35 ERROR - # TBPL SUCCESS # 07:18:35 INFO - Running post-action listener: _resource_record_post_action 07:18:35 INFO - [mozharness: 2017-03-24 14:18:35.013945Z] Finished run-tests step (success) 07:18:35 INFO - Running post-run listener: _resource_record_post_run 07:18:35 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 361066496; Read time: 20; Write time: 253348 07:18:35 INFO - TinderboxPrint: CPU usage
13.3% 07:18:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 07:18:35 INFO - TinderboxPrint: I/O write bytes / time
361,066,496 / 253,348 07:18:35 INFO - TinderboxPrint: CPU idle
8,316.5 (86.7%) 07:18:35 INFO - TinderboxPrint: CPU user
1,218.7 (12.7%) 07:18:35 INFO - TinderboxPrint: Swap in / out
0 / 0 07:18:35 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105857024; Read time: 0; Write time: 112560 07:18:35 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254849024; Read time: 20; Write time: 140764 07:18:35 INFO - Running post-run listener: _upload_blobber_files 07:18:35 INFO - Blob upload gear active. 07:18:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:18:35 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:35 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:36 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:36 INFO - (blobuploader) - INFO - Done attempting. 07:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:37 INFO - (blobuploader) - INFO - Done attempting. 07:18:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:18:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:18:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:38 INFO - (blobuploader) - INFO - Done attempting. 07:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:41 INFO - (blobuploader) - INFO - Done attempting. 07:18:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:41 INFO - Return code: 0 07:18:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b65a6458aeb7b0c55730bae0fd337948451d5cb4cba60d1be1d30a5922bf46e5009974be0ca1ee4c3fd75c0fff885b1ee6573950dca84224f42d63a25faf3814", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48110711d9a2f430a60e5d37aa46a23a07260290c9c97fd6d43e3a6da6e9addd7c5fb0a1eb695a6b99efe7aead983fe95838bf2b4a30783e37c6165000f13993", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0da3b28b0c26dcf70ab0781bcbd4b1caa8b331971078ec94e4b5b34b2265a861a06aed3d4db3ee1c27c4408f6f386f6ac3628b815ec438579850db7ed8c705e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05f2784a47ce7e552a737c71a5c1d13bd2b7b573550b9fb0a95e87795affbc299d4e0b8209f8a457d6b5e5007d18fb25a00a335bdda6862b006c566ee1604ab1"} 07:18:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:41 INFO - Contents: 07:18:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b65a6458aeb7b0c55730bae0fd337948451d5cb4cba60d1be1d30a5922bf46e5009974be0ca1ee4c3fd75c0fff885b1ee6573950dca84224f42d63a25faf3814", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48110711d9a2f430a60e5d37aa46a23a07260290c9c97fd6d43e3a6da6e9addd7c5fb0a1eb695a6b99efe7aead983fe95838bf2b4a30783e37c6165000f13993", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0da3b28b0c26dcf70ab0781bcbd4b1caa8b331971078ec94e4b5b34b2265a861a06aed3d4db3ee1c27c4408f6f386f6ac3628b815ec438579850db7ed8c705e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05f2784a47ce7e552a737c71a5c1d13bd2b7b573550b9fb0a95e87795affbc299d4e0b8209f8a457d6b5e5007d18fb25a00a335bdda6862b006c566ee1604ab1"} 07:18:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:41 INFO - Copying logs to upload dir... 07:18:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.559871 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-24 07:18:41.445504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:41.449611) ========= 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=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 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/Firefox-Non-PGO/sha512/b65a6458aeb7b0c55730bae0fd337948451d5cb4cba60d1be1d30a5922bf46e5009974be0ca1ee4c3fd75c0fff885b1ee6573950dca84224f42d63a25faf3814", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48110711d9a2f430a60e5d37aa46a23a07260290c9c97fd6d43e3a6da6e9addd7c5fb0a1eb695a6b99efe7aead983fe95838bf2b4a30783e37c6165000f13993", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0da3b28b0c26dcf70ab0781bcbd4b1caa8b331971078ec94e4b5b34b2265a861a06aed3d4db3ee1c27c4408f6f386f6ac3628b815ec438579850db7ed8c705e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05f2784a47ce7e552a737c71a5c1d13bd2b7b573550b9fb0a95e87795affbc299d4e0b8209f8a457d6b5e5007d18fb25a00a335bdda6862b006c566ee1604ab1"} build_url:https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011334 build_url: 'https://queue.taskcluster.net/v1/task/EXURsPqFRXmx5uvPxmZMtA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b65a6458aeb7b0c55730bae0fd337948451d5cb4cba60d1be1d30a5922bf46e5009974be0ca1ee4c3fd75c0fff885b1ee6573950dca84224f42d63a25faf3814", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/48110711d9a2f430a60e5d37aa46a23a07260290c9c97fd6d43e3a6da6e9addd7c5fb0a1eb695a6b99efe7aead983fe95838bf2b4a30783e37c6165000f13993", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0da3b28b0c26dcf70ab0781bcbd4b1caa8b331971078ec94e4b5b34b2265a861a06aed3d4db3ee1c27c4408f6f386f6ac3628b815ec438579850db7ed8c705e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05f2784a47ce7e552a737c71a5c1d13bd2b7b573550b9fb0a95e87795affbc299d4e0b8209f8a457d6b5e5007d18fb25a00a335bdda6862b006c566ee1604ab1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:41.475226) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:41.475553) ========= 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=0333a256a5e4f052382dd180000001b1-1490363328.565279-284148147 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 07:18:41.561073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:18:41.561394) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 07:18:41.561750) ========= ========= Total master_lag: 0.17 =========